builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1457973046.18 results: success (0) buildid: 20160314090034 builduid: e674a1d08d6b48818369da5831f0d757 revision: d50f024f55d81364ead7bdb729b01746399325c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.184939) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.185348) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.185625) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004923 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.235876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.236198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.281247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.281502) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.330393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.330668) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.331017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.331285) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 09:30:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-03-14 09:30:46 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.546291) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.546564) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.595544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:46.595888) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d50f024f55d81364ead7bdb729b01746399325c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d50f024f55d81364ead7bdb729b01746399325c5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 09:30:46,842 truncating revision to first 12 chars 2016-03-14 09:30:46,842 Setting DEBUG logging. 2016-03-14 09:30:46,842 attempt 1/10 2016-03-14 09:30:46,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d50f024f55d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 09:30:47,103 unpacking tar archive at: fx-team-d50f024f55d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555587 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:47.164020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:47.164343) ========= echo d50f024f55d81364ead7bdb729b01746399325c5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd50f024f55d81364ead7bdb729b01746399325c5'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d50f024f55d81364ead7bdb729b01746399325c5 program finished with exit code 0 elapsedTime=0.003761 script_repo_revision: 'd50f024f55d81364ead7bdb729b01746399325c5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:47.212284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:47.212568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 09:30:47.223136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-03-14 09:30:47.223406) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:47 INFO - MultiFileLogger online at 20160314 09:30:47 in /builds/slave/test 09:30:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:30:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:47 INFO - {'append_to_log': False, 09:30:47 INFO - 'base_work_dir': '/builds/slave/test', 09:30:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:30:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:47 INFO - 'branch': 'Fx-Team-Non-PGO', 09:30:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:47 INFO - 'config_files': ('talos/linux_config.py',), 09:30:47 INFO - 'default_actions': ('clobber', 09:30:47 INFO - 'read-buildbot-config', 09:30:47 INFO - 'download-and-extract', 09:30:47 INFO - 'populate-webroot', 09:30:47 INFO - 'create-virtualenv', 09:30:47 INFO - 'install', 09:30:47 INFO - 'run-tests'), 09:30:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:47 INFO - 'download_minidump_stackwalk': True, 09:30:47 INFO - 'download_symbols': 'ondemand', 09:30:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:47 INFO - 'installer_path': 'installer.exe', 09:30:47 INFO - 'log_level': 'info', 09:30:47 INFO - 'log_name': 'talos', 09:30:47 INFO - 'log_to_console': True, 09:30:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:47 INFO - 'opt_config_files': (), 09:30:47 INFO - 'pip_index': False, 09:30:47 INFO - 'sps_profile': False, 09:30:47 INFO - 'sps_profile_interval': 0, 09:30:47 INFO - 'suite': 'dromaeojs-e10s', 09:30:47 INFO - 'system_bits': '32', 09:30:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:47 INFO - 'title': 'talos-linux64-ix-025', 09:30:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:47 INFO - 'use_talos_json': True, 09:30:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:47 INFO - 'work_dir': 'build'} 09:30:47 INFO - ##### 09:30:47 INFO - ##### Running clobber step. 09:30:47 INFO - ##### 09:30:47 INFO - Running pre-action listener: _resource_record_pre_action 09:30:47 INFO - Running main action method: clobber 09:30:47 INFO - rmtree: /builds/slave/test/build 09:30:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:48 INFO - Running post-action listener: _resource_record_post_action 09:30:48 INFO - ##### 09:30:48 INFO - ##### Running read-buildbot-config step. 09:30:48 INFO - ##### 09:30:48 INFO - Running pre-action listener: _resource_record_pre_action 09:30:48 INFO - Running main action method: read_buildbot_config 09:30:48 INFO - Using buildbot properties: 09:30:48 INFO - { 09:30:48 INFO - "project": "", 09:30:48 INFO - "product": "firefox", 09:30:48 INFO - "script_repo_revision": "production", 09:30:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:30:48 INFO - "repository": "", 09:30:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:30:48 INFO - "buildid": "20160314090034", 09:30:48 INFO - "pgo_build": "False", 09:30:48 INFO - "basedir": "/builds/slave/test", 09:30:48 INFO - "buildnumber": 1044, 09:30:48 INFO - "slavename": "talos-linux64-ix-025", 09:30:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:30:48 INFO - "platform": "ubuntu64_hw", 09:30:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:30:48 INFO - "branch": "fx-team", 09:30:48 INFO - "repo_path": "integration/fx-team", 09:30:48 INFO - "revision": "d50f024f55d81364ead7bdb729b01746399325c5", 09:30:48 INFO - "stage_platform": "linux64", 09:30:48 INFO - "builduid": "e674a1d08d6b48818369da5831f0d757", 09:30:48 INFO - "slavebuilddir": "test" 09:30:48 INFO - } 09:30:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:30:48 INFO - Running post-action listener: _resource_record_post_action 09:30:48 INFO - ##### 09:30:48 INFO - ##### Running download-and-extract step. 09:30:48 INFO - ##### 09:30:48 INFO - Running pre-action listener: _resource_record_pre_action 09:30:48 INFO - Running main action method: download_and_extract 09:30:48 INFO - mkdir: /builds/slave/test/build/tests 09:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:48 INFO - https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:30:48 INFO - Downloaded 1361 bytes. 09:30:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:30:48 INFO - Using the following test package requirements: 09:30:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:30:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'jsshell-linux-x86_64.zip'], 09:30:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:30:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:30:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:48 INFO - https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:01 INFO - Downloaded 21991097 bytes. 09:31:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:31:02 INFO - Return code: 0 09:31:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:02 INFO - https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:06 INFO - Downloaded 21991097 bytes. 09:31:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:31:08 INFO - Return code: 0 09:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:08 INFO - https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:31:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:31:09 INFO - Downloaded 10845263 bytes. 09:31:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:31:09 INFO - Return code: 0 09:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:09 INFO - https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:31:10 INFO - Downloaded 54134226 bytes. 09:31:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:31:10 INFO - mkdir: /builds/slave/test/properties 09:31:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:10 INFO - Contents: 09:31:10 INFO - build_url:https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:31:11 INFO - Running post-action listener: _resource_record_post_action 09:31:11 INFO - Running post-action listener: set_extra_try_arguments 09:31:11 INFO - ##### 09:31:11 INFO - ##### Running populate-webroot step. 09:31:11 INFO - ##### 09:31:11 INFO - Running pre-action listener: _resource_record_pre_action 09:31:11 INFO - Running main action method: populate_webroot 09:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:11 INFO - '--tppagecycles', 09:31:11 INFO - '7'], 09:31:11 INFO - 'tests': ['tsvgm']}}, 09:31:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:31:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:31:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['damp', 'tps']}, 09:31:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['damp', 'tps']}, 09:31:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:11 INFO - 'other': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'other_l64': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'other_nol64': {'tests': ['a11yr', 09:31:11 INFO - 'ts_paint', 09:31:11 INFO - 'tpaint', 09:31:11 INFO - 'sessionrestore', 09:31:11 INFO - 'sessionrestore_no_auto_restore', 09:31:11 INFO - 'tabpaint']}, 09:31:11 INFO - 'svgr': {'tests': ['tsvgx', 09:31:11 INFO - 'tsvgr_opacity', 09:31:11 INFO - 'tart', 09:31:11 INFO - 'tscrollx', 09:31:11 INFO - 'cart']}, 09:31:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tsvgx', 09:31:11 INFO - 'tsvgr_opacity', 09:31:11 INFO - 'tart', 09:31:11 INFO - 'tscrollx', 09:31:11 INFO - 'cart']}, 09:31:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'tests': ['tp5o']}, 09:31:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s'], 09:31:11 INFO - 'tests': ['tp5o']}, 09:31:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--xperf_path', 09:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:11 INFO - 'tests': ['tp5n']}, 09:31:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:11 INFO - 'talos_options': ['--e10s', 09:31:11 INFO - '--xperf_path', 09:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:11 INFO - 'tests': ['tp5n']}}, 09:31:11 INFO - 'talos.zip': {'path': '', 09:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:11 INFO - Running post-action listener: _resource_record_post_action 09:31:11 INFO - ##### 09:31:11 INFO - ##### Running create-virtualenv step. 09:31:11 INFO - ##### 09:31:11 INFO - Running pre-action listener: _resource_record_pre_action 09:31:11 INFO - Running main action method: create_virtualenv 09:31:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:11 INFO - Using real prefix '/usr' 09:31:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:15 INFO - Installing pip.................done. 09:31:15 INFO - Return code: 0 09:31:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:15 INFO - Using env: {'DISPLAY': ':0', 09:31:15 INFO - 'HOME': '/home/cltbld', 09:31:15 INFO - 'LANG': 'en_US.UTF-8', 09:31:15 INFO - 'LANGUAGE': 'en_US:en', 09:31:15 INFO - 'LOGNAME': 'cltbld', 09:31:15 INFO - 'MAIL': '/var/mail/cltbld', 09:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:15 INFO - 'MOZ_NO_REMOTE': '1', 09:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:15 INFO - 'NO_EM_RESTART': '1', 09:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:15 INFO - 'PWD': '/builds/slave/test', 09:31:15 INFO - 'SHELL': '/bin/bash', 09:31:15 INFO - 'SHLVL': '1', 09:31:15 INFO - 'TERM': 'linux', 09:31:15 INFO - 'TMOUT': '86400', 09:31:15 INFO - 'USER': 'cltbld', 09:31:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:15 INFO - '_': '/tools/buildbot/bin/python'} 09:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:31:15 INFO - Cleaning up... 09:31:15 INFO - Return code: 0 09:31:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:31:15 INFO - Using env: {'DISPLAY': ':0', 09:31:15 INFO - 'HOME': '/home/cltbld', 09:31:15 INFO - 'LANG': 'en_US.UTF-8', 09:31:15 INFO - 'LANGUAGE': 'en_US:en', 09:31:15 INFO - 'LOGNAME': 'cltbld', 09:31:15 INFO - 'MAIL': '/var/mail/cltbld', 09:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:15 INFO - 'MOZ_NO_REMOTE': '1', 09:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:15 INFO - 'NO_EM_RESTART': '1', 09:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:15 INFO - 'PWD': '/builds/slave/test', 09:31:15 INFO - 'SHELL': '/bin/bash', 09:31:15 INFO - 'SHLVL': '1', 09:31:15 INFO - 'TERM': 'linux', 09:31:15 INFO - 'TMOUT': '86400', 09:31:15 INFO - 'USER': 'cltbld', 09:31:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:15 INFO - '_': '/tools/buildbot/bin/python'} 09:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:15 INFO - Downloading/unpacking psutil>=0.7.1 09:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:17 INFO - Installing collected packages: psutil 09:31:17 INFO - Running setup.py install for psutil 09:31:18 INFO - building 'psutil._psutil_linux' extension 09:31:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:31:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:31:19 INFO - building 'psutil._psutil_posix' extension 09:31:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:31:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:19 INFO - Successfully installed psutil 09:31:19 INFO - Cleaning up... 09:31:19 INFO - Return code: 0 09:31:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:31:19 INFO - Using env: {'DISPLAY': ':0', 09:31:19 INFO - 'HOME': '/home/cltbld', 09:31:19 INFO - 'LANG': 'en_US.UTF-8', 09:31:19 INFO - 'LANGUAGE': 'en_US:en', 09:31:19 INFO - 'LOGNAME': 'cltbld', 09:31:19 INFO - 'MAIL': '/var/mail/cltbld', 09:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:19 INFO - 'MOZ_NO_REMOTE': '1', 09:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:19 INFO - 'NO_EM_RESTART': '1', 09:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:19 INFO - 'PWD': '/builds/slave/test', 09:31:19 INFO - 'SHELL': '/bin/bash', 09:31:19 INFO - 'SHLVL': '1', 09:31:19 INFO - 'TERM': 'linux', 09:31:19 INFO - 'TMOUT': '86400', 09:31:19 INFO - 'USER': 'cltbld', 09:31:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:19 INFO - '_': '/tools/buildbot/bin/python'} 09:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:31:22 INFO - Installing collected packages: mozsystemmonitor 09:31:22 INFO - Running setup.py install for mozsystemmonitor 09:31:22 INFO - Successfully installed mozsystemmonitor 09:31:22 INFO - Cleaning up... 09:31:22 INFO - Return code: 0 09:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:31:22 INFO - Using env: {'DISPLAY': ':0', 09:31:22 INFO - 'HOME': '/home/cltbld', 09:31:22 INFO - 'LANG': 'en_US.UTF-8', 09:31:22 INFO - 'LANGUAGE': 'en_US:en', 09:31:22 INFO - 'LOGNAME': 'cltbld', 09:31:22 INFO - 'MAIL': '/var/mail/cltbld', 09:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:22 INFO - 'MOZ_NO_REMOTE': '1', 09:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:22 INFO - 'NO_EM_RESTART': '1', 09:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:22 INFO - 'PWD': '/builds/slave/test', 09:31:22 INFO - 'SHELL': '/bin/bash', 09:31:22 INFO - 'SHLVL': '1', 09:31:22 INFO - 'TERM': 'linux', 09:31:22 INFO - 'TMOUT': '86400', 09:31:22 INFO - 'USER': 'cltbld', 09:31:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:22 INFO - '_': '/tools/buildbot/bin/python'} 09:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:31:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:24 INFO - Downloading docopt-0.6.1.tar.gz 09:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:25 INFO - Running setup.py install for blobuploader 09:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:31:25 INFO - Running setup.py install for requests 09:31:25 INFO - Running setup.py install for docopt 09:31:25 INFO - Successfully installed blobuploader requests docopt 09:31:25 INFO - Cleaning up... 09:31:25 INFO - Return code: 0 09:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:25 INFO - Using env: {'DISPLAY': ':0', 09:31:25 INFO - 'HOME': '/home/cltbld', 09:31:25 INFO - 'LANG': 'en_US.UTF-8', 09:31:25 INFO - 'LANGUAGE': 'en_US:en', 09:31:25 INFO - 'LOGNAME': 'cltbld', 09:31:25 INFO - 'MAIL': '/var/mail/cltbld', 09:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:25 INFO - 'MOZ_NO_REMOTE': '1', 09:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:25 INFO - 'NO_EM_RESTART': '1', 09:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:25 INFO - 'PWD': '/builds/slave/test', 09:31:25 INFO - 'SHELL': '/bin/bash', 09:31:25 INFO - 'SHLVL': '1', 09:31:25 INFO - 'TERM': 'linux', 09:31:25 INFO - 'TMOUT': '86400', 09:31:25 INFO - 'USER': 'cltbld', 09:31:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:25 INFO - '_': '/tools/buildbot/bin/python'} 09:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:25 INFO - Running setup.py (path:/tmp/pip-lNTdXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:25 INFO - Running setup.py (path:/tmp/pip-CLFRS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:25 INFO - Running setup.py (path:/tmp/pip-DwI4_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:26 INFO - Running setup.py (path:/tmp/pip-mEjJkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:26 INFO - Running setup.py (path:/tmp/pip-C3JaQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:26 INFO - Running setup.py (path:/tmp/pip-sQ1X3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:26 INFO - Running setup.py (path:/tmp/pip-9NCLBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:26 INFO - Running setup.py (path:/tmp/pip-HoKkkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:26 INFO - Running setup.py (path:/tmp/pip-fAXpXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:26 INFO - Running setup.py (path:/tmp/pip-Id7bfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:26 INFO - Running setup.py (path:/tmp/pip-dkn0OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:26 INFO - Running setup.py (path:/tmp/pip-vVIj97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:26 INFO - Running setup.py (path:/tmp/pip-53j0OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:26 INFO - Running setup.py (path:/tmp/pip-lytrfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:26 INFO - Running setup.py (path:/tmp/pip-cjvF4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:26 INFO - Running setup.py (path:/tmp/pip-9Z0ABx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:26 INFO - Running setup.py (path:/tmp/pip-ONwQmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:27 INFO - Running setup.py install for manifestparser 09:31:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Running setup.py install for mozcrash 09:31:27 INFO - Running setup.py install for mozdebug 09:31:27 INFO - Running setup.py install for mozdevice 09:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Running setup.py install for mozfile 09:31:27 INFO - Running setup.py install for mozhttpd 09:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Running setup.py install for mozinfo 09:31:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Running setup.py install for mozInstall 09:31:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:31:27 INFO - Running setup.py install for mozleak 09:31:27 INFO - Running setup.py install for mozlog 09:31:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Running setup.py install for moznetwork 09:31:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Running setup.py install for mozprocess 09:31:28 INFO - Running setup.py install for mozprofile 09:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Running setup.py install for mozrunner 09:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Running setup.py install for mozscreenshot 09:31:28 INFO - Running setup.py install for moztest 09:31:28 INFO - Running setup.py install for mozversion 09:31:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:31:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:28 INFO - Cleaning up... 09:31:28 INFO - Return code: 0 09:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:28 INFO - Using env: {'DISPLAY': ':0', 09:31:28 INFO - 'HOME': '/home/cltbld', 09:31:28 INFO - 'LANG': 'en_US.UTF-8', 09:31:28 INFO - 'LANGUAGE': 'en_US:en', 09:31:28 INFO - 'LOGNAME': 'cltbld', 09:31:28 INFO - 'MAIL': '/var/mail/cltbld', 09:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:28 INFO - 'MOZ_NO_REMOTE': '1', 09:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:28 INFO - 'NO_EM_RESTART': '1', 09:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:28 INFO - 'PWD': '/builds/slave/test', 09:31:28 INFO - 'SHELL': '/bin/bash', 09:31:28 INFO - 'SHLVL': '1', 09:31:28 INFO - 'TERM': 'linux', 09:31:28 INFO - 'TMOUT': '86400', 09:31:28 INFO - 'USER': 'cltbld', 09:31:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:28 INFO - '_': '/tools/buildbot/bin/python'} 09:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:29 INFO - Running setup.py (path:/tmp/pip-oTZsTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:29 INFO - Running setup.py (path:/tmp/pip-Y9A0xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:29 INFO - Running setup.py (path:/tmp/pip-n24_DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:29 INFO - Running setup.py (path:/tmp/pip-e0ddrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:29 INFO - Running setup.py (path:/tmp/pip-iaY2Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:29 INFO - Running setup.py (path:/tmp/pip-nvIfqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:29 INFO - Running setup.py (path:/tmp/pip-Q_epDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:29 INFO - Running setup.py (path:/tmp/pip-eLOVsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:29 INFO - Running setup.py (path:/tmp/pip-HWSMAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:29 INFO - Running setup.py (path:/tmp/pip-oyqO66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:29 INFO - Running setup.py (path:/tmp/pip-Ronj5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:29 INFO - Running setup.py (path:/tmp/pip-pwHLpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:29 INFO - Running setup.py (path:/tmp/pip-_y_Xpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:29 INFO - Running setup.py (path:/tmp/pip-6sgifn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:30 INFO - Running setup.py (path:/tmp/pip-z92hiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:30 INFO - Running setup.py (path:/tmp/pip-RQDH_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:30 INFO - Running setup.py (path:/tmp/pip-082t0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:32 INFO - Downloading blessings-1.6.tar.gz 09:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:32 INFO - Installing collected packages: blessings 09:31:32 INFO - Running setup.py install for blessings 09:31:32 INFO - Successfully installed blessings 09:31:32 INFO - Cleaning up... 09:31:32 INFO - Return code: 0 09:31:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:32 INFO - Reading from file tmpfile_stdout 09:31:32 INFO - Current package versions: 09:31:32 INFO - argparse == 1.2.1 09:31:32 INFO - blessings == 1.6 09:31:32 INFO - blobuploader == 1.2.4 09:31:32 INFO - docopt == 0.6.1 09:31:32 INFO - manifestparser == 1.1 09:31:32 INFO - mozInstall == 1.12 09:31:32 INFO - mozcrash == 0.17 09:31:32 INFO - mozdebug == 0.1 09:31:32 INFO - mozdevice == 0.48 09:31:32 INFO - mozfile == 1.2 09:31:32 INFO - mozhttpd == 0.7 09:31:32 INFO - mozinfo == 0.9 09:31:32 INFO - mozleak == 0.1 09:31:32 INFO - mozlog == 3.1 09:31:32 INFO - moznetwork == 0.27 09:31:32 INFO - mozprocess == 0.22 09:31:32 INFO - mozprofile == 0.28 09:31:32 INFO - mozrunner == 6.11 09:31:32 INFO - mozscreenshot == 0.1 09:31:32 INFO - mozsystemmonitor == 0.0 09:31:32 INFO - moztest == 0.7 09:31:32 INFO - mozversion == 1.4 09:31:32 INFO - psutil == 3.1.1 09:31:32 INFO - requests == 1.2.3 09:31:32 INFO - wsgiref == 0.1.2 09:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:32 INFO - Using env: {'DISPLAY': ':0', 09:31:32 INFO - 'HOME': '/home/cltbld', 09:31:32 INFO - 'LANG': 'en_US.UTF-8', 09:31:32 INFO - 'LANGUAGE': 'en_US:en', 09:31:32 INFO - 'LOGNAME': 'cltbld', 09:31:32 INFO - 'MAIL': '/var/mail/cltbld', 09:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:32 INFO - 'MOZ_NO_REMOTE': '1', 09:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:32 INFO - 'NO_EM_RESTART': '1', 09:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:32 INFO - 'PWD': '/builds/slave/test', 09:31:32 INFO - 'SHELL': '/bin/bash', 09:31:32 INFO - 'SHLVL': '1', 09:31:32 INFO - 'TERM': 'linux', 09:31:32 INFO - 'TMOUT': '86400', 09:31:32 INFO - 'USER': 'cltbld', 09:31:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:32 INFO - '_': '/tools/buildbot/bin/python'} 09:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:31:32 INFO - Cleaning up... 09:31:32 INFO - Return code: 0 09:31:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:31:32 INFO - Using env: {'DISPLAY': ':0', 09:31:32 INFO - 'HOME': '/home/cltbld', 09:31:32 INFO - 'LANG': 'en_US.UTF-8', 09:31:32 INFO - 'LANGUAGE': 'en_US:en', 09:31:32 INFO - 'LOGNAME': 'cltbld', 09:31:32 INFO - 'MAIL': '/var/mail/cltbld', 09:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:32 INFO - 'MOZ_NO_REMOTE': '1', 09:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:32 INFO - 'NO_EM_RESTART': '1', 09:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:32 INFO - 'PWD': '/builds/slave/test', 09:31:32 INFO - 'SHELL': '/bin/bash', 09:31:32 INFO - 'SHLVL': '1', 09:31:32 INFO - 'TERM': 'linux', 09:31:32 INFO - 'TMOUT': '86400', 09:31:32 INFO - 'USER': 'cltbld', 09:31:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:32 INFO - '_': '/tools/buildbot/bin/python'} 09:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:33 INFO - Downloading/unpacking jsonschema 09:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:34 INFO - Downloading/unpacking functools32 (from jsonschema) 09:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:35 INFO - warning: no files found matching '*.txt' 09:31:35 INFO - no previously-included directories found matching 'build' 09:31:35 INFO - no previously-included directories found matching 'dist' 09:31:35 INFO - no previously-included directories found matching '.git*' 09:31:35 INFO - Installing collected packages: jsonschema, functools32 09:31:35 INFO - Running setup.py install for functools32 09:31:35 INFO - warning: no files found matching '*.txt' 09:31:35 INFO - no previously-included directories found matching 'build' 09:31:35 INFO - no previously-included directories found matching 'dist' 09:31:35 INFO - no previously-included directories found matching '.git*' 09:31:35 INFO - Successfully installed jsonschema functools32 09:31:35 INFO - Cleaning up... 09:31:35 INFO - Return code: 0 09:31:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b690d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2764410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:31:35 INFO - Using env: {'DISPLAY': ':0', 09:31:35 INFO - 'HOME': '/home/cltbld', 09:31:35 INFO - 'LANG': 'en_US.UTF-8', 09:31:35 INFO - 'LANGUAGE': 'en_US:en', 09:31:35 INFO - 'LOGNAME': 'cltbld', 09:31:35 INFO - 'MAIL': '/var/mail/cltbld', 09:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:35 INFO - 'MOZ_NO_REMOTE': '1', 09:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:35 INFO - 'NO_EM_RESTART': '1', 09:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:35 INFO - 'PWD': '/builds/slave/test', 09:31:35 INFO - 'SHELL': '/bin/bash', 09:31:35 INFO - 'SHLVL': '1', 09:31:35 INFO - 'TERM': 'linux', 09:31:35 INFO - 'TMOUT': '86400', 09:31:35 INFO - 'USER': 'cltbld', 09:31:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:35 INFO - '_': '/tools/buildbot/bin/python'} 09:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:35 INFO - Downloading/unpacking flake8 09:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:31:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:31:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:31:38 INFO - no previously-included directories found matching 'docs/_build' 09:31:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:31:38 INFO - Running setup.py install for pep8 09:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:31:38 INFO - no previously-included directories found matching 'docs/_build' 09:31:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:31:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:31:38 INFO - Cleaning up... 09:31:38 INFO - Return code: 0 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - Running post-action listener: _start_resource_monitoring 09:31:38 INFO - Starting resource monitoring. 09:31:38 INFO - ##### 09:31:38 INFO - ##### Running install step. 09:31:38 INFO - ##### 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: install 09:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:38 INFO - Reading from file tmpfile_stdout 09:31:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:31:38 INFO - Reading from file tmpfile_stdout 09:31:38 INFO - Output received: 09:31:38 INFO - Usage: mozinstall [options] installer 09:31:38 INFO - Options: 09:31:38 INFO - -h, --help show this help message and exit 09:31:38 INFO - -d DEST, --destination=DEST 09:31:38 INFO - Directory to install application into. [default: 09:31:38 INFO - "/builds/slave/test"] 09:31:38 INFO - --app=APP Application being installed. [default: firefox] 09:31:38 INFO - mkdir: /builds/slave/test/build/application 09:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:31:54 INFO - Reading from file tmpfile_stdout 09:31:54 INFO - Output received: 09:31:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:31:54 INFO - Running post-action listener: _resource_record_post_action 09:31:54 INFO - ##### 09:31:54 INFO - ##### Running run-tests step. 09:31:54 INFO - ##### 09:31:54 INFO - Running pre-action listener: _resource_record_pre_action 09:31:54 INFO - Running main action method: run_tests 09:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:54 INFO - Python 2.7.3 09:31:54 INFO - Return code: 0 09:31:54 INFO - grabbing minidump binary from tooltool 09:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f44f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:31:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:31:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:54 INFO - Return code: 0 09:31:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:31:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:31:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:31:55 INFO - Return code: 0 09:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:31:55 INFO - Using env: {'DISPLAY': ':0', 09:31:55 INFO - 'HOME': '/home/cltbld', 09:31:55 INFO - 'LANG': 'en_US.UTF-8', 09:31:55 INFO - 'LANGUAGE': 'en_US:en', 09:31:55 INFO - 'LOGNAME': 'cltbld', 09:31:55 INFO - 'MAIL': '/var/mail/cltbld', 09:31:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:55 INFO - 'MOZ_NO_REMOTE': '1', 09:31:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:55 INFO - 'NO_EM_RESTART': '1', 09:31:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:55 INFO - 'PWD': '/builds/slave/test', 09:31:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:55 INFO - 'SHELL': '/bin/bash', 09:31:55 INFO - 'SHLVL': '1', 09:31:55 INFO - 'TERM': 'linux', 09:31:55 INFO - 'TMOUT': '86400', 09:31:55 INFO - 'USER': 'cltbld', 09:31:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359', 09:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:55 INFO - '_': '/tools/buildbot/bin/python'} 09:31:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:31:55 INFO - mozversion application_buildid: 20160314090034 09:31:55 INFO - mozversion application_changeset: d50f024f55d81364ead7bdb729b01746399325c5 09:31:55 INFO - mozversion application_display_name: Nightly 09:31:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:55 INFO - mozversion application_name: Firefox 09:31:55 INFO - mozversion application_remotingname: firefox 09:31:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:31:55 INFO - mozversion application_vendor: Mozilla 09:31:55 INFO - mozversion application_version: 48.0a1 09:31:55 INFO - mozversion platform_buildid: 20160314090034 09:31:55 INFO - mozversion platform_changeset: d50f024f55d81364ead7bdb729b01746399325c5 09:31:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:31:55 INFO - mozversion platform_version: 48.0a1 09:31:55 INFO - using testdate: 1457973115 09:31:55 INFO - actual date: 1457973115 09:31:55 INFO - starting webserver on 'localhost:37858' 09:31:55 INFO - SUITE-START | Running 2 tests 09:31:55 INFO - TEST-START | dromaeo_css 09:31:55 INFO - operating with platform_type : linux_ 09:31:55 INFO - Initialising browser for dromaeo_css test... 09:31:55 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlKEsA/profile http://localhost:37858/getInfo.html) 09:32:01 INFO - PROCESS | 3327 | 09:32:01 INFO - PROCESS | 3327 | (process:3407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:32:02 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 09:32:02 INFO - PROCESS | 3327 | colorDepth:24 09:32:02 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 09:32:02 INFO - PROCESS | 3327 | __metrics 09:32:03 ERROR - PROCESS | 3327 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 09:32:04 INFO - TEST-INFO | 3327: exit 0 09:32:04 INFO - Browser initialized. 09:32:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:04 INFO - TEST-INFO | started process 3459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlKEsA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:06 INFO - PROCESS | 3459 | 09:32:06 INFO - PROCESS | 3459 | (process:3520): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:32:16 INFO - PROCESS | 3459 | RSS: Main: 165720064 09:32:16 INFO - PROCESS | 3459 | 09:33:05 INFO - PROCESS | 3459 | 1457973185625 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:35:16 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37858/tests/dromaeo/cssquery-ext.html) 09:35:17 INFO - PROCESS | 3459 | RSS: Main: 167829504 09:35:17 INFO - PROCESS | 3459 | 09:38:19 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-ext.html (next: http://localhost:37858/tests/dromaeo/cssquery-jquery.html) 09:38:20 INFO - PROCESS | 3459 | RSS: Main: 169336832 09:38:20 INFO - PROCESS | 3459 | 09:41:22 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37858/tests/dromaeo/cssquery-mootools.html) 09:41:22 INFO - PROCESS | 3459 | RSS: Main: 169500672 09:41:22 INFO - PROCESS | 3459 | 09:44:24 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37858/tests/dromaeo/cssquery-prototype.html) 09:44:25 INFO - PROCESS | 3459 | RSS: Main: 166678528 09:44:25 INFO - PROCESS | 3459 | 09:47:27 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37858/tests/dromaeo/cssquery-yui.html) 09:47:28 INFO - PROCESS | 3459 | RSS: Main: 167190528 09:47:28 INFO - PROCESS | 3459 | 09:50:30 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37858/tests/dromaeo/cssquery-yui.html (next: http://localhost:37858/tests/dromaeo/cssquery-dojo.html) 09:50:31 INFO - PROCESS | 3459 | RSS: Main: 171622400 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | __start_tp_report 09:50:31 INFO - PROCESS | 3459 | _x_x_mozilla_page_load 09:50:31 INFO - PROCESS | 3459 | _x_x_mozilla_page_load_details 09:50:31 INFO - PROCESS | 3459 | |i|pagename|runs| 09:50:31 INFO - PROCESS | 3459 | |0;dojo.html;2632.973670263297;2686.5029969455645;2694.703582605914;2734.3984323448835;2740.8903643854246;4682.110399024183;4731.266653668678;4768.666193366465;4773.976130119345;4812.181929072058;4606.700564463316;4660.440747110351;4688.156131896258;4755.762211889409;4822.662413631038;4344.804483798229;4435.68950173488;4440.97779511102;4444.97777511112;4447.84432544861;422.0955849727798;4282.14357128574;4318.9784051079705;4334.0681753423005;4402.559744025604;4268.911427585946;4288.69979101463;4319.222539942809;4332.805023773938;4390.990072283361;4293.549177336397;4322.308430651112;4330.328799036123;4345.956540434587;4382.452193475816;4329.437173167499;4349.325854492558;4355.716878402925;4382.430284063052;4398.7580683062415;4574.130915126116;4597.448306203243;4597.816087356502;4635.721856688576;4675.251959686468;4980.8754781130765;5011.6241281904;5048.7980480780725;5059.443461219263;5060.645754797166;5096.566791822699;5104.61715371345;5111.361079865017;5129.384473863123;5145.15105007677;4750.382450281476;4793.616510679138;4794.2089555223;4801.903961920742;4847.030593881203;5147.1507201312115;5188.766505507186;5215.374155101412;5233.188855727369;5295.761690723926;4879.072976134523;4899.510048995072;4917.065757506062;4965.82619608312;4974.1543937530705;5010.223415370623;5022.246663000579;5028.195488721787;5037.219231019198;5057.31726216956;4912.263160525878;4939.209726443752;5043.697378157249;5045.2432135180015;5050.419201791768;5003.924941125886;5059.620528460307;5067.569256613156;5070.594352451869;5091.745412729349;4271.380649805761;4272.16692744918;4283.850065247701;4317.956820431818;4320.416743739618;3666.816659167031;3678.2091850252323;3708.666220040155;3714.817675837325;3725.6646901778972;4438.7114837535455;4440.35614835847;4466.888327791767;4498.50516443191;4550.203714349976;5106.770195341219;5154.561862241677;5155.948440515547;5156.159242214358;5210.687358758487;4381.6494680425485;4436.223660859337;4484.686071974996;4504.909901801946;4512.097580483916;4504.301833215857;4533.886652833706;4546.65900057497;4548.7725613719185;4601.562851529099;4801.7118972861745;4813.438055838724;4825.252085926687;4831.492693267156;4864.36763220779;5057.924131137962;5073.416557095981;5112.335396398445;5135;5152.381714194321;4771.71369717818;4817.325574419514;4835.95164048355;4843.95156048435;4865;4938.7530623467965;4990.700557966534;4991.226359914219;4999.800007999639;4999.900002000012;5066.113430149635;5110.923336149886;5123.87190320245;5144.845654630367;5173.094708426086;5011;5013.974930125326;5017.84946451607;5019.146745053276;5060.8987820242655;4912.508749125059;4930.063287975273;4996.100701873697;5009.273655320031;5015.874603134951;4816.735079570657;4846.200376937766;4909.459959404391;4935.16102262609;4965.0566392385335;4975.875603109951;4989.176785830443;4990.80036798524;4992.675476094042;5019.196928491424;4824.34871292371;4862;4866.926996095132;4887.851354931659;4891.168501354707 09:50:31 INFO - PROCESS | 3459 | |1;ext.html;500.9048280826645;534.156033467122;537.3202898333609;541.9756110975005;554.9084401073823;34176.829115854416;34498;34576.481352779665;34628.4805727914;34658.999999999935;36935.63064369362;38211.80894095533;38350.23299534015;38417.80791096041;38596.22807543854;7468.402527797777;7708.498947568418;7721.884171737428;7728.884066739003;7729.652165652531;7437.925620743805;7452.552846829208;7499.962500187491;7729.072511298652;7739.032620922385;7610.086789585258;7617.162112167657;7635.809104772369;7668.539887606734;7688.769336919873;7580.431467639922;7633.961830190841;7659.961700191491;7706.306432421109;7733.45865789395;7689.077310722693;7786.3381612563;7849.4897831640765;7870.252326029075;7879.724209652692;35685.28629427423;35944.64055359439;36032;36102;36190.819045904864;2670.5460071787843;2985.880564777406;3376.763626546143;3607.3687104756564;3651.8721844735305;25368;25699.229023129148;26139.346516337053;26263.868680656666;26310.473790524084;3324.7672662913606;3381.1209085637665;3403.5915690117345;3407.2504049109157;3525.682688558042;164101;165308;166331.99999999878;166560.16719916323;166973;42145.78927105406;42655.36016959748;54133;54477;54541;43198;44207.55792442099;44262.778686106365;44376.11247775026;44389;14347.92826035884;14415.78376324356;14437.855621443861;14526.564203073925;14587.562373128823;10725.51735171919;10905.890941090645;10921.617743378943;10938.343699378063;10972.177086718528;14526.636834079232;14687.118772873662;14696.55910322692;14712.779308310384;14813.629659258604;6026.728797204137;6043.428708535725;6077.604955677867;6086.2087928569;6203.596766210182;853.8121613245077;861.763015170833;905.5336501701629;932.8274269260208;998.8301988661945;26132.608010879852;26440.8677956609;26955.05657301985;27043.32391690184;27174.5923811143;981.7349315684725;1001.5593139018808;1027.814993301198;1077.4181941751524;1112.4604566785104;13858.099223550638;14033.78949315761;14203.431862725376;14252.073615214978;14280.42878284857;296469;298632;301230;301850;302719;45568.54431455643;45735;46193.7690311553;46428.5357146431;46675.5332446678;1167.6672148437824;1177.8233265010317;1215.7993931001286;1231.4520038582746;1232.1436601562007;25936.481270374865;27024.72975270222;27047.45905081848;27484.725152748215;27610.861945690143;41407;41501.58498414977;41604.37593436161;41786;41872.581274186865;271785;276033;276978;277954;278088;31580.204048131916;31665.20836979002;32287;32315.19212019718;32426.83786581052;40993;41124;41265.1746965053;41606.37590436085;41854.79072604617;35454;35468;35695.82152089223;35696.64303356933;35824.28351433009;33694.8315258432;33970.66029339675;34011.82994085113;34408;34463.483047753805;28816.711832881403;33962.66037339694;34034.65965340315;34651.13372165716;34824.12939676528;26575.867120664272;27298;29118;29178.27054323574;29512.852435737685;23515.882420587786;24145.97941854111;24195.879020604785;24394.390140246636;24438.755612444358 09:50:31 INFO - PROCESS | 3459 | |2;jquery.html;343.4144783144738;351.6624040920714;357.3014756151723;360.1410635634012;360.27764332513306;15245.39018439261;15579.298931548079;16056.839431605695;16514.669706605862;16550.089745064015;15128.16795076273;15563;16572;16681.49955501334;16695.165241737926;4821.13219620469;4918.163912134945;5075.898482030358;5096.872578185556;5145.382554093514;5018.222175562793;5057.367829021372;5078.136716758141;5087.414947281073;5094.083065048289;5049.772760225798;5072.2391641253735;5074.923876141861;5077.009983053306;5090.618203634742;4783.091212669599;4868.318435419062;4896.632752543574;4898.191798353268;4938.38270216223;4324.567543245682;4353.673474489395;4361.062371590092;4363.301871700544;4370.10412865365;18607.883526988426;19754;20097.698534521995;20133.295334663362;20143.899280503505;1911.0731295321757;1924.3457224543722;1929.488685498344;2065.824404925583;2388.773066558674;8414.495130292202;12880.227186368847;13112.47550097995;13340.666483337896;13409.128406653535;1551.6043408930764;1564.8200456947484;1591.618011677189;1609.7504886742574;1700.5153531243536;55564.444355556734;63203;63844.361556384305;66387.34031649199;66873.66563167152;9551.952240238754;9725.951370243103;10171.186305095574;10541.84187237192;10560.2079844012;13319.200847949154;13369.66575835612;13420;13463.528776492776;13481.056326057082;7803.68785248595;7842.411819113589;7851.136374998746;7864.252895974873;7994.320482759031;7736.4584479085925;7737.497062690907;7774.961125194338;7805.297523222937;7850.8429831403055;4429.402030725811;4471.485779135441;4499.932501012488;4519.480259770103;4594.88512787183;1827.15950662694;1860.135037207705;1897.8291953723956;1905.6284024615345;1919.2418994497095;796.0964305513285;825.6449726617612;865.9177378149066;872.4808738800403;907.9773005674779;13965.58103256904;15822.05067695942;15986;16235.350585976665;16467.917660411862;899.1278459893892;904.2314033071967;904.2359206470522;941.7033634405141;947.8151760406655;9259.953700231456;9540.189083927806;9658.9034109658;9663.806723865484;9703.17523010552;407523;424872;426130;429481;429531;70869.29130708627;72942.63528682322;73580.63209683917;73986;75626.24373756192;912.8539433690711;915.7390143808982;920.282179899666;922.9723108306628;932.1750251027889;14612.196329201995;14800.48198313054;14973.251337432866;15080.773788392964;15136.621584460476;33392.833035834665;33678.49482257817;33822;34028;34589.82705086459;46037;47443.76278118588;47664.52335476601;47734.76132619315;47889;7402.851942961003;7571.621418928921;7582.976298199893;7585.6965721370525;7653.311201991847;10918.890811091787;11087.889121108685;11115.499802508744;11355.261907975955;11592.1305902056;9511.61953521879;9603.327767056518;9856.753581160528;9901.702948911545;9958.502074896081;8722.476651400937;10082.747931301776;10128.34165779222;10172.898271017195;10262.43556604394;9999.400035997864;10039.69880903574;10114.393136411838;10143.188544916242;10235.948820255851;7385.409167266498;7520.135184453858;7598.506097103671;7755.844883102193;7756.767296981099;8797.956010219908;9379.718608441757;9501.192398646193;9982.201423886218;10062.798744025225 09:50:31 INFO - PROCESS | 3459 | |3;mootools.html;1425.3158483927714;1429.5782744090493;1595.2183430119237;1758.894466332021;1785.482210159054;6493.805185844432;6971.477139214554;7219.711211551538;7419.295166959137;7445.627718614068;7384.22465641108;7399.223081576424;7458.030456040707;7458.105027396707;7486.850262994737;2173.0873033326043;2203.10774136475;2210.6794514795347;2211.402921211272;2234.6759719840616;2165.981988465419;2171.272623671072;2230.8326875484404;2250.516139030108;2264.184893438361;2204.481946742514;2212.9225477108303;2231.3752149398197;2232.9330120096424;2240.787125223101;2240.630296001158;2243.8990245438913;2252.234240358278;2253.4929640830765;2260.9095636174698;2173.1416090644266;2177.3903307074042;2188.4091295350167;2191.3206905859233;2200.866553724833;7455.142658594277;7530.548167109991;7549;7618.923810761877;7662.693492260303;4592.632589392841;4690.835820746292;4692.929606055912;4702.3181638662545;4707.929381059253;2797.8740956656998;2905.2882043899167;2948.9705102949124;2966.896158634459;2981.8807247710065;884.5400391796294;927.6938610258599;933.5332333833084;976.4385478349906;992.9970729563121;10369.688909332657;10430.478476076241;10445.738856528571;10478.214133939984;10484.370937743759;4249.086446414036;4285.871423857289;4302.182585308781;4348.304271316638;4359.912801743947;8930.955345223232;8984.146506081912;9009.144131307516;9019.684311049214;9019.77450563728;4511.88720281989;4560.361549383089;4585.931211031837;4592.334111553806;4596.172688916027;3743.139078012018;4069.9389509157386;4077.8368865245056;4103.035786590149;4160.417541544186;3590.5152804371596;3606.6213047630145;3690.8892733218045;3731.4029755239576;3738.0467980664757;1179.2511755035614;1190.6130507584896;1223.1988047828686;1226.7178548933616;1234.9814752778716;946.3375637054089;992.4987881119988;998.3460833154296;1071.8552995345528;1246.4515613130193;7038.2961703829205;7108;7138.9286107139305;7156.964215178891;7160.641967901584;451.7086479220884;452.7034792211107;454.03064457383067;457.7070674768151;458.6285109061671;5377.623566350318;5444.8094316698725;5463.399026107125;5468.152436372368;5479.315085614298;8940.597673104727;9214.308926830514;9269.536523173814;9312.860307095263;9314.673986410444;8843.115688431106;9055.773605659911;9108.8633670495;9134.22359099484;9182.081791820765;6752.5948443093575;6843.965780171067;6868.416184624263;6899.413549848319;6956.443484521226;6629.071929929717;6654.334566543307;6676.165479315086;6754.729810807513;6786.049953006682;8008.799780005546;8134.105248422788;8192.959035204785;8213.83572328562;8226.547539885363;8294.488826271348;8339.416240863082;8340.124286949784;8393;8405.075441701285;5512.889742205213;6107.847303817262;6212.1303017578475;6571.671416429255;6704.530682852153;6936.687849046906;6948.166220053626;6963.860722785617;6990.405815505739;7004.334588214111;6276.843078923063;6307.400796924285;6356.586821856565;6372.681365931778;6391.10524526576;6236.656983865931;6265.248170219603;6313;6385.553011289351;6416.486681065597;6508.437974885898;6700.698468569024;6704.7988560343265;6727.293634168537;6744.7976560703255;6182.536309776695;6199.752009919553;6234.376562343729;6243.125962365363;6301.149344838388;6380.042993551005;6399.688063946786;6431.260405053479;6434.324395938359;6435.871282574416 09:50:31 INFO - PROCESS | 3459 | |4;prototype.html;316.22209364962197;317.4096181103148;322.92572708277095;323.10822130918655;324.67045948362403;5615.354234263061;5771.624844385112;5794.449527294911;5794.855128621786;5797.681127537984;5688.146777983305;5710.114932185507;5715.77136914524;5717.77128914844;5742.770289188438;4184.246835569596;4319.654427645796;4359.564043595631;4397.582229688174;4408.470983481987;4370.2133615949115;4373.278409062501;4375.409319741826;4385.758783266919;4385.912281754363;4350.390945267665;4351.260285751414;4359.673024523157;4367.257566213735;4368.279233926399;4309.396684464177;4328.04782947751;4347.913041739179;4372.901007516378;4375.518692943773;3800.37293846515;3800.581935987067;3803.9619603803885;3806.3909774435956;3806.54321481424;5398.91901621476;5447.046766815792;5454.072807622713;5468.398476167618;5478.561715062785;4800.207965685658;4950.975245123787;4994.400671919393;5008.499150084999;5013.896942672643;5982.820515384546;6013.789517366871;6017.2779266488305;6021.187139736124;6028.819135425944;4101.2207680540605;4108.506979162519;4114.280000999813;4119.526254480713;4137;6186.133941248228;6271.34150914152;6293.402126797947;6297.2128483939505;6363.363663633646;4241.97879010603;4242.618164365222;4244.681648876285;4246.872593822129;4252.255855225323;4304.773139655246;4326.069894972596;4340.348947657813;4340.392345071693;4345.97827010863;4818.590419814285;4938.703677779345;4942.308076869242;4965.255211718271;4970.428400733889;5955.612885162451;5961.344252132262;5966.522678185735;5969.283685957713;5975.193348897843;1492.7014597080627;1497.9325930333162;1507.6532397548626;1509.4264179611678;1509.8641122299045;953.4001362000248;972.776261459854;984.9753756156153;985.2758222706306;1006.3710181136789;5253.684778913277;5265.078611243017;5270.077736396115;5289.550388217045;5303.973480132575;6207.34822843604;6258.718357673915;6259.530535209787;6260.749570017239;6265.404786545362;5171.01750667372;5291.3385826771655;5312.5484333832055;5332.146856503018;5339.3058902342445;3327.8169700666213;3343.6656334366367;3373.983130084334;3415.6755108264674;3421.7433692473164;5820.923129221108;5856.092305692625;5884.411558844167;5919.940800592025;5926.436988486087;6469.77355792545;6470.417662410406;6474.482041436674;6482.448991835747;6485.3514648534765;5830.212921255661;5830.533557315404;5903.085021821625;5939.673317967553;5943.554233432424;6028.246469191351;6218.098375735583;6276.905846412399;6283.874322513616;6291.811245662638;6206.410391012847;6212.968935155476;6291;6291.276503202191;6302.684865756602;5816.302043754607;5825.796097136749;5947.672877991752;5960.970195148997;5962.880742385041;4145.7719825409895;4187;4247.87256382309;4258.87223383299;4271.996080921043;6187.16473276102;6228.972219583718;6263.091851681572;6263.718132684131;6273.498120150468;5876.294844618673;6022.247219097613;6065.636061836304;6082.330943596289;6086.360932102066;6043.607165534227;6070.3019152798;6070.362611925861;6074.483668888017;6137.232845894263;5913.822585322448;5940.673262970578;5956;5962;5962;5964.642121472725;6061.272647282354;6078.5441091919165;6141.201643786458;6152.630842149485;5765.97117014429;5801.76792928295;5904.734286957183;5989.401059893976;5995.16067750524 09:50:31 INFO - PROCESS | 3459 | |5;yui.html;722.4437183368806;742.7029188324672;793.9087004994427;794.2414993681035;795.6697970342308;10808.459577021147;10970.945145274272;11071.667849964493;12460.626181214555;12469.189502682319;14195.929020354884;14272.857271427283;14273.78589321161;14278.643033924158;14282;772.4554189296532;797.8204903896635;798.4530596541359;803.4054799448395;805.4764403137949;636.5353292096772;791.268077028749;799.2367289238792;802.8193656427286;804.7384600004992;823.4770920465518;839.2237180607943;844.1474111147724;845.1084106267884;846.6867259114106;802.5906787538369;827.210014436215;830.73001274586;831.9958400208021;836.2431999040817;606.169547719627;614.5053232148119;621.0497938154631;627.4415769964735;627.6767464755654;12562.74874502514;12587.874121258761;12588.496460141583;12610.873891261153;12636;12486.375681215994;12767;12843.422046007952;12872.22766634005;13101.606951791366;8593.871091933626;8642.697505587274;8723.38936274461;8745.256653184488;8778.868316975251;3218.8873389431255;3219.5331676906953;3239.3360699625173;3251.658575849549;3291.391092647868;43788.781056094835;44165;44205.77897110526;44402.33396499023;44462.77768611169;10069.194464442828;10240.334378265388;10319.896801031893;10614;10674.78650426987;17313.04778237209;17334.133293335282;17479.737803932952;17551.91224043897;17666.734998975026;6671.33286671329;6772.424343930821;6807.21717002551;6825.658717064127;6878.896816547755;3675.852965881335;3695.060674068081;3715.7398982070995;3742.079165896837;3775.2260786538695;2633.1310667479684;2683.5437975544205;2693.4074503609177;2698.5682290833374;2704.0535812465478;501.8695139263818;510.4232217594095;513.3019094032113;513.6276199755148;518.7406296851574;590.6987436407463;607.1651479216077;607.5413063137391;629.5341447328943;636.8980963045983;7059.8235044123285;7433.925660743432;7473.738419155304;7530.096388433423;7708.190639982833;447.40495141461776;511.51150651128086;586.4897539140975;593.7268856326139;601.8044135655929;3456.6543345665737;3524.1894364296354;3550.7336949728874;3556.039869235292;3611.368010598135;54955.45044549504;59135;59710.70144649336;60148;60283.69858150681;49320;49893.501064988886;51056.74471627618;51806.927722891414;51941.48058519366;43372.34941475943;43694.78152609216;44084.779576101915;44398.33402498965;45066.32400513995;8165.877511837446;8552.144785521397;8687.869681954902;8830.646774128963;8969.295833791559;34737.65262347445;35322.11694707653;36048.459273111446;36368.81815590905;36713.63286367209;43781.56218437775;43814.34278485889;43959.560404395546;44062.33906491341;44543;9856.162226210852;9949.154321882721;10378.42918639482;10610.469476526298;10717.35695858251;11860.169788114748;12061.401317170477;12384.876151238732;12478.251304921734;12524.311162886128;11759.647210583697;11873.82189267179;12219.816702749287;12385.566505172275;12480.5007799687;10962.890371096506;10975.670729878117;11427.142964277546;11601.709957250798;11722.706932326419;10426.843597345895;10926.78146437051;10964.725881853017;11170.832437513607;11322.716932076764;8962.775930601527;9000.86498702533;9013.953119107604;9555;9600.567974441026;9378.812423751624;9448.28378830825;9500.144986951207;9932.155766759906;10065.728638192762 09:50:31 INFO - PROCESS | 3459 | __end_tp_report 09:50:31 INFO - PROCESS | 3459 | __start_cc_report 09:50:31 INFO - PROCESS | 3459 | _x_x_mozilla_cycle_collect,343 09:50:31 INFO - PROCESS | 3459 | __end_cc_report 09:50:31 INFO - PROCESS | 3459 | __startTimestamp1457974231026__endTimestamp 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | ------- Summary: start ------- 09:50:31 INFO - PROCESS | 3459 | Number of tests: 6 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#0] dojo.html Cycles:165 Average:4672.85 Median:4835.95 stddev:592.30 (12.2%) stddev-sans-first:572.09 09:50:31 INFO - PROCESS | 3459 | Values: 2633.0 2686.5 2694.7 2734.4 2740.9 4682.1 4731.3 4768.7 4774.0 4812.2 4606.7 4660.4 4688.2 4755.8 4822.7 4344.8 4435.7 4441.0 4445.0 4447.8 422.1 4282.1 4319.0 4334.1 4402.6 4268.9 4288.7 4319.2 4332.8 4391.0 4293.5 4322.3 4330.3 4346.0 4382.5 4329.4 4349.3 4355.7 4382.4 4398.8 4574.1 4597.4 4597.8 4635.7 4675.3 4980.9 5011.6 5048.8 5059.4 5060.6 5096.6 5104.6 5111.4 5129.4 5145.2 4750.4 4793.6 4794.2 4801.9 4847.0 5147.2 5188.8 5215.4 5233.2 5295.8 4879.1 4899.5 4917.1 4965.8 4974.2 5010.2 5022.2 5028.2 5037.2 5057.3 4912.3 4939.2 5043.7 5045.2 5050.4 5003.9 5059.6 5067.6 5070.6 5091.7 4271.4 4272.2 4283.9 4318.0 4320.4 3666.8 3678.2 3708.7 3714.8 3725.7 4438.7 4440.4 4466.9 4498.5 4550.2 5106.8 5154.6 5155.9 5156.2 5210.7 4381.6 4436.2 4484.7 4504.9 4512.1 4504.3 4533.9 4546.7 4548.8 4601.6 4801.7 4813.4 4825.3 4831.5 4864.4 5057.9 5073.4 5112.3 5135.0 5152.4 4771.7 4817.3 4836.0 4844.0 4865.0 4938.8 4990.7 4991.2 4999.8 4999.9 5066.1 5110.9 5123.9 5144.8 5173.1 5011.0 5014.0 5017.8 5019.1 5060.9 4912.5 4930.1 4996.1 5009.3 5015.9 4816.7 4846.2 4909.5 4935.2 4965.1 4975.9 4989.2 4990.8 4992.7 5019.2 4824.3 4862.0 4866.9 4887.9 4891.2 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#1] ext.html Cycles:180 Average:40273.14 Median:34537.24 stddev:66566.71 (192.7%) stddev-sans-first:66686.46 09:50:31 INFO - PROCESS | 3459 | Values: 500.9 534.2 537.3 542.0 554.9 34176.8 34498.0 34576.5 34628.5 34659.0 36935.6 38211.8 38350.2 38417.8 38596.2 7468.4 7708.5 7721.9 7728.9 7729.7 7437.9 7452.6 7500.0 7729.1 7739.0 7610.1 7617.2 7635.8 7668.5 7688.8 7580.4 7634.0 7660.0 7706.3 7733.5 7689.1 7786.3 7849.5 7870.3 7879.7 35685.3 35944.6 36032.0 36102.0 36190.8 2670.5 2985.9 3376.8 3607.4 3651.9 25368.0 25699.2 26139.3 26263.9 26310.5 3324.8 3381.1 3403.6 3407.3 3525.7 164101.0 165308.0 166332.0 166560.2 166973.0 42145.8 42655.4 54133.0 54477.0 54541.0 43198.0 44207.6 44262.8 44376.1 44389.0 14347.9 14415.8 14437.9 14526.6 14587.6 10725.5 10905.9 10921.6 10938.3 10972.2 14526.6 14687.1 14696.6 14712.8 14813.6 6026.7 6043.4 6077.6 6086.2 6203.6 853.8 861.8 905.5 932.8 998.8 26132.6 26440.9 26955.1 27043.3 27174.6 981.7 1001.6 1027.8 1077.4 1112.5 13858.1 14033.8 14203.4 14252.1 14280.4 296469.0 298632.0 301230.0 301850.0 302719.0 45568.5 45735.0 46193.8 46428.5 46675.5 1167.7 1177.8 1215.8 1231.5 1232.1 25936.5 27024.7 27047.5 27484.7 27610.9 41407.0 41501.6 41604.4 41786.0 41872.6 271785.0 276033.0 276978.0 277954.0 278088.0 31580.2 31665.2 32287.0 32315.2 32426.8 40993.0 41124.0 41265.2 41606.4 41854.8 35454.0 35468.0 35695.8 35696.6 35824.3 33694.8 33970.7 34011.8 34408.0 34463.5 28816.7 33962.7 34034.7 34651.1 34824.1 26575.9 27298.0 29118.0 29178.3 29512.9 23515.9 24146.0 24195.9 24394.4 24438.8 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#2] jquery.html Cycles:180 Average:24664.48 Median:25315.94 stddev:69539.92 (274.7%) stddev-sans-first:69711.02 09:50:31 INFO - PROCESS | 3459 | Values: 343.4 351.7 357.3 360.1 360.3 15245.4 15579.3 16056.8 16514.7 16550.1 15128.2 15563.0 16572.0 16681.5 16695.2 4821.1 4918.2 5075.9 5096.9 5145.4 5018.2 5057.4 5078.1 5087.4 5094.1 5049.8 5072.2 5074.9 5077.0 5090.6 4783.1 4868.3 4896.6 4898.2 4938.4 4324.6 4353.7 4361.1 4363.3 4370.1 18607.9 19754.0 20097.7 20133.3 20143.9 1911.1 1924.3 1929.5 2065.8 2388.8 8414.5 12880.2 13112.5 13340.7 13409.1 1551.6 1564.8 1591.6 1609.8 1700.5 55564.4 63203.0 63844.4 66387.3 66873.7 9552.0 9726.0 10171.2 10541.8 10560.2 13319.2 13369.7 13420.0 13463.5 13481.1 7803.7 7842.4 7851.1 7864.3 7994.3 7736.5 7737.5 7775.0 7805.3 7850.8 4429.4 4471.5 4499.9 4519.5 4594.9 1827.2 1860.1 1897.8 1905.6 1919.2 796.1 825.6 865.9 872.5 908.0 13965.6 15822.1 15986.0 16235.4 16467.9 899.1 904.2 904.2 941.7 947.8 9260.0 9540.2 9658.9 9663.8 9703.2 407523.0 424872.0 426130.0 429481.0 429531.0 70869.3 72942.6 73580.6 73986.0 75626.2 912.9 915.7 920.3 923.0 932.2 14612.2 14800.5 14973.3 15080.8 15136.6 33392.8 33678.5 33822.0 34028.0 34589.8 46037.0 47443.8 47664.5 47734.8 47889.0 7402.9 7571.6 7583.0 7585.7 7653.3 10918.9 11087.9 11115.5 11355.3 11592.1 9511.6 9603.3 9856.8 9901.7 9958.5 8722.5 10082.7 10128.3 10172.9 10262.4 9999.4 10039.7 10114.4 10143.2 10235.9 7385.4 7520.1 7598.5 7755.8 7756.8 8798.0 9379.7 9501.2 9982.2 10062.8 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#3] mootools.html Cycles:180 Average:5226.75 Median:6271.05 stddev:2736.34 (43.6%) stddev-sans-first:2729.10 09:50:31 INFO - PROCESS | 3459 | Values: 1425.3 1429.6 1595.2 1758.9 1785.5 6493.8 6971.5 7219.7 7419.3 7445.6 7384.2 7399.2 7458.0 7458.1 7486.9 2173.1 2203.1 2210.7 2211.4 2234.7 2166.0 2171.3 2230.8 2250.5 2264.2 2204.5 2212.9 2231.4 2232.9 2240.8 2240.6 2243.9 2252.2 2253.5 2260.9 2173.1 2177.4 2188.4 2191.3 2200.9 7455.1 7530.5 7549.0 7618.9 7662.7 4592.6 4690.8 4692.9 4702.3 4707.9 2797.9 2905.3 2949.0 2966.9 2981.9 884.5 927.7 933.5 976.4 993.0 10369.7 10430.5 10445.7 10478.2 10484.4 4249.1 4285.9 4302.2 4348.3 4359.9 8931.0 8984.1 9009.1 9019.7 9019.8 4511.9 4560.4 4585.9 4592.3 4596.2 3743.1 4069.9 4077.8 4103.0 4160.4 3590.5 3606.6 3690.9 3731.4 3738.0 1179.3 1190.6 1223.2 1226.7 1235.0 946.3 992.5 998.3 1071.9 1246.5 7038.3 7108.0 7138.9 7157.0 7160.6 451.7 452.7 454.0 457.7 458.6 5377.6 5444.8 5463.4 5468.2 5479.3 8940.6 9214.3 9269.5 9312.9 9314.7 8843.1 9055.8 9108.9 9134.2 9182.1 6752.6 6844.0 6868.4 6899.4 6956.4 6629.1 6654.3 6676.2 6754.7 6786.0 8008.8 8134.1 8193.0 8213.8 8226.5 8294.5 8339.4 8340.1 8393.0 8405.1 5512.9 6107.8 6212.1 6571.7 6704.5 6936.7 6948.2 6963.9 6990.4 7004.3 6276.8 6307.4 6356.6 6372.7 6391.1 6236.7 6265.2 6313.0 6385.6 6416.5 6508.4 6700.7 6704.8 6727.3 6744.8 6182.5 6199.8 6234.4 6243.1 6301.1 6380.0 6399.7 6431.3 6434.3 6435.9 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#4] prototype.html Cycles:180 Average:4974.81 Median:5730.27 stddev:1488.74 (26.0%) stddev-sans-first:1451.27 09:50:31 INFO - PROCESS | 3459 | Values: 316.2 317.4 322.9 323.1 324.7 5615.4 5771.6 5794.4 5794.9 5797.7 5688.1 5710.1 5715.8 5717.8 5742.8 4184.2 4319.7 4359.6 4397.6 4408.5 4370.2 4373.3 4375.4 4385.8 4385.9 4350.4 4351.3 4359.7 4367.3 4368.3 4309.4 4328.0 4347.9 4372.9 4375.5 3800.4 3800.6 3804.0 3806.4 3806.5 5398.9 5447.0 5454.1 5468.4 5478.6 4800.2 4951.0 4994.4 5008.5 5013.9 5982.8 6013.8 6017.3 6021.2 6028.8 4101.2 4108.5 4114.3 4119.5 4137.0 6186.1 6271.3 6293.4 6297.2 6363.4 4242.0 4242.6 4244.7 4246.9 4252.3 4304.8 4326.1 4340.3 4340.4 4346.0 4818.6 4938.7 4942.3 4965.3 4970.4 5955.6 5961.3 5966.5 5969.3 5975.2 1492.7 1497.9 1507.7 1509.4 1509.9 953.4 972.8 985.0 985.3 1006.4 5253.7 5265.1 5270.1 5289.6 5304.0 6207.3 6258.7 6259.5 6260.7 6265.4 5171.0 5291.3 5312.5 5332.1 5339.3 3327.8 3343.7 3374.0 3415.7 3421.7 5820.9 5856.1 5884.4 5919.9 5926.4 6469.8 6470.4 6474.5 6482.4 6485.4 5830.2 5830.5 5903.1 5939.7 5943.6 6028.2 6218.1 6276.9 6283.9 6291.8 6206.4 6213.0 6291.0 6291.3 6302.7 5816.3 5825.8 5947.7 5961.0 5962.9 4145.8 4187.0 4247.9 4258.9 4272.0 6187.2 6229.0 6263.1 6263.7 6273.5 5876.3 6022.2 6065.6 6082.3 6086.4 6043.6 6070.3 6070.4 6074.5 6137.2 5913.8 5940.7 5956.0 5962.0 5962.0 5964.6 6061.3 6078.5 6141.2 6152.6 5766.0 5801.8 5904.7 5989.4 5995.2 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - PROCESS | 3459 | [#5] yui.html Cycles:180 Average:13441.07 Median:44432.56 stddev:15745.99 (35.4%) stddev-sans-first:15761.20 09:50:31 INFO - PROCESS | 3459 | Values: 722.4 742.7 793.9 794.2 795.7 10808.5 10970.9 11071.7 12460.6 12469.2 14195.9 14272.9 14273.8 14278.6 14282.0 772.5 797.8 798.5 803.4 805.5 636.5 791.3 799.2 802.8 804.7 823.5 839.2 844.1 845.1 846.7 802.6 827.2 830.7 832.0 836.2 606.2 614.5 621.0 627.4 627.7 12562.7 12587.9 12588.5 12610.9 12636.0 12486.4 12767.0 12843.4 12872.2 13101.6 8593.9 8642.7 8723.4 8745.3 8778.9 3218.9 3219.5 3239.3 3251.7 3291.4 43788.8 44165.0 44205.8 44402.3 44462.8 10069.2 10240.3 10319.9 10614.0 10674.8 17313.0 17334.1 17479.7 17551.9 17666.7 6671.3 6772.4 6807.2 6825.7 6878.9 3675.9 3695.1 3715.7 3742.1 3775.2 2633.1 2683.5 2693.4 2698.6 2704.1 501.9 510.4 513.3 513.6 518.7 590.7 607.2 607.5 629.5 636.9 7059.8 7433.9 7473.7 7530.1 7708.2 447.4 511.5 586.5 593.7 601.8 3456.7 3524.2 3550.7 3556.0 3611.4 54955.5 59135.0 59710.7 60148.0 60283.7 49320.0 49893.5 51056.7 51806.9 51941.5 43372.3 43694.8 44084.8 44398.3 45066.3 8165.9 8552.1 8687.9 8830.6 8969.3 34737.7 35322.1 36048.5 36368.8 36713.6 43781.6 43814.3 43959.6 44062.3 44543.0 9856.2 9949.2 10378.4 10610.5 10717.4 11860.2 12061.4 12384.9 12478.3 12524.3 11759.6 11873.8 12219.8 12385.6 12480.5 10962.9 10975.7 11427.1 11601.7 11722.7 10426.8 10926.8 10964.7 11170.8 11322.7 8962.8 9000.9 9014.0 9555.0 9600.6 9378.8 9448.3 9500.1 9932.2 10065.7 09:50:31 INFO - PROCESS | 3459 | -------- Summary: end -------- 09:50:31 INFO - PROCESS | 3459 | 09:50:31 INFO - TEST-INFO | 3459: exit 0 09:50:31 INFO - TEST-OK | dromaeo_css | took 1115929ms 09:50:31 INFO - TEST-START | kraken 09:50:31 INFO - operating with platform_type : linux_ 09:50:31 INFO - Initialising browser for kraken test... 09:50:31 INFO - TEST-INFO | started process 3695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Uh4Zs/profile http://localhost:37858/getInfo.html) 09:50:35 INFO - PROCESS | 3695 | 09:50:35 INFO - PROCESS | 3695 | (process:3765): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:50:36 INFO - PROCESS | 3695 | __metrics Screen width/height:1600/1200 09:50:36 INFO - PROCESS | 3695 | colorDepth:24 09:50:36 INFO - PROCESS | 3695 | Browser inner width/height: 1024/697 09:50:36 INFO - PROCESS | 3695 | __metrics 09:50:37 ERROR - PROCESS | 3695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 09:50:38 INFO - TEST-INFO | 3695: exit 0 09:50:38 INFO - Browser initialized. 09:50:38 INFO - Running cycle 1/1 for kraken test... 09:50:38 INFO - TEST-INFO | started process 3817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Uh4Zs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:40 INFO - PROCESS | 3817 | 09:50:40 INFO - PROCESS | 3817 | (process:3877): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:50:50 INFO - PROCESS | 3817 | RSS: Main: 166223872 09:50:50 INFO - PROCESS | 3817 | 09:50:52 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37858/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:53 INFO - PROCESS | 3817 | RSS: Main: 170295296 09:50:53 INFO - PROCESS | 3817 | 09:50:56 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37858/tests/kraken/driver.html?testName=audio-dft) 09:50:56 INFO - PROCESS | 3817 | RSS: Main: 171696128 09:50:56 INFO - PROCESS | 3817 | 09:51:02 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37858/tests/kraken/driver.html?testName=audio-fft) 09:51:02 INFO - PROCESS | 3817 | RSS: Main: 167333888 09:51:02 INFO - PROCESS | 3817 | 09:51:04 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37858/tests/kraken/driver.html?testName=audio-oscillator) 09:51:05 INFO - PROCESS | 3817 | RSS: Main: 168534016 09:51:05 INFO - PROCESS | 3817 | 09:51:07 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:08 INFO - PROCESS | 3817 | RSS: Main: 166887424 09:51:08 INFO - PROCESS | 3817 | 09:51:11 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37858/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:12 INFO - PROCESS | 3817 | RSS: Main: 168558592 09:51:12 INFO - PROCESS | 3817 | 09:51:16 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37858/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:16 INFO - PROCESS | 3817 | RSS: Main: 166768640 09:51:16 INFO - PROCESS | 3817 | 09:51:19 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37858/tests/kraken/driver.html?testName=json-parse-financial) 09:51:20 INFO - PROCESS | 3817 | RSS: Main: 167002112 09:51:20 INFO - PROCESS | 3817 | 09:51:22 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:22 INFO - PROCESS | 3817 | RSS: Main: 167981056 09:51:22 INFO - PROCESS | 3817 | 09:51:24 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:25 INFO - PROCESS | 3817 | RSS: Main: 168603648 09:51:25 INFO - PROCESS | 3817 | 09:51:27 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:27 INFO - PROCESS | 3817 | RSS: Main: 168947712 09:51:27 INFO - PROCESS | 3817 | 09:51:30 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:31 INFO - PROCESS | 3817 | RSS: Main: 169312256 09:51:31 INFO - PROCESS | 3817 | 09:51:33 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:34 INFO - PROCESS | 3817 | RSS: Main: 168644608 09:51:34 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:37858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37858/tests/kraken/driver.html?testName=ai-astar) 09:51:36 INFO - PROCESS | 3817 | RSS: Main: 169381888 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | __start_tp_report 09:51:36 INFO - PROCESS | 3817 | _x_x_mozilla_page_load 09:51:36 INFO - PROCESS | 3817 | _x_x_mozilla_page_load_details 09:51:36 INFO - PROCESS | 3817 | |i|pagename|runs| 09:51:36 INFO - PROCESS | 3817 | |0;ai-astar;117;110;113;116;116;127;113;113;113;117 09:51:36 INFO - PROCESS | 3817 | |1;audio-beat-detection;155;136;159;173;132;153;158;136;178;130 09:51:36 INFO - PROCESS | 3817 | |2;audio-dft;389;389;392;386;385;388;387;388;387;387 09:51:36 INFO - PROCESS | 3817 | |3;audio-fft;78;75;77;152;76;76;74;74;153;79 09:51:36 INFO - PROCESS | 3817 | |4;audio-oscillator;94;94;137;94;93;95;151;95;94;137 09:51:36 INFO - PROCESS | 3817 | |5;imaging-gaussian-blur;118;119;118;117;118;118;117;118;118;117 09:51:36 INFO - PROCESS | 3817 | |6;imaging-darkroom;197;197;195;197;197;196;196;196;195;197 09:51:36 INFO - PROCESS | 3817 | |7;imaging-desaturate;100;96;96;96;97;97;98;96;96;96 09:51:36 INFO - PROCESS | 3817 | |8;json-parse-financial;67;67;67;66;67;71;66;67;69;66 09:51:36 INFO - PROCESS | 3817 | |9;json-stringify-tinderbox;64;64;65;65;65;69;65;65;64;64 09:51:36 INFO - PROCESS | 3817 | |10;stanford-crypto-aes;81;81;84;90;82;80;83;84;98;86 09:51:36 INFO - PROCESS | 3817 | |11;stanford-crypto-ccm;129;124;117;121;127;123;132;119;124;120 09:51:36 INFO - PROCESS | 3817 | |12;stanford-crypto-pbkdf2;129;141;142;153;144;139;152;138;141;130 09:51:36 INFO - PROCESS | 3817 | |13;stanford-crypto-sha256-iterative;65;69;66;68;66;69;68;73;65;68 09:51:36 INFO - PROCESS | 3817 | __end_tp_report 09:51:36 INFO - PROCESS | 3817 | __start_cc_report 09:51:36 INFO - PROCESS | 3817 | _x_x_mozilla_cycle_collect,879 09:51:36 INFO - PROCESS | 3817 | __end_cc_report 09:51:36 INFO - PROCESS | 3817 | __startTimestamp1457974296443__endTimestamp 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | ------- Summary: start ------- 09:51:36 INFO - PROCESS | 3817 | Number of tests: 14 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:4.62 (4.0%) stddev-sans-first:4.87 09:51:36 INFO - PROCESS | 3817 | Values: 117.0 110.0 113.0 116.0 116.0 127.0 113.0 113.0 113.0 117.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:156.50 stddev:16.99 (10.9%) stddev-sans-first:17.96 09:51:36 INFO - PROCESS | 3817 | Values: 155.0 136.0 159.0 173.0 132.0 153.0 158.0 136.0 178.0 130.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#2] audio-dft Cycles:10 Average:387.80 Median:388.00 stddev:1.93 (0.5%) stddev-sans-first:2.00 09:51:36 INFO - PROCESS | 3817 | Values: 389.0 389.0 392.0 386.0 385.0 388.0 387.0 388.0 387.0 387.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#3] audio-fft Cycles:10 Average:91.40 Median:76.00 stddev:32.24 (42.4%) stddev-sans-first:33.83 09:51:36 INFO - PROCESS | 3817 | Values: 78.0 75.0 77.0 152.0 76.0 76.0 74.0 74.0 153.0 79.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:23.28 (24.8%) stddev-sans-first:24.10 09:51:36 INFO - PROCESS | 3817 | Values: 94.0 94.0 137.0 94.0 93.0 95.0 151.0 95.0 94.0 137.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:51:36 INFO - PROCESS | 3817 | Values: 118.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#6] imaging-darkroom Cycles:10 Average:196.30 Median:197.00 stddev:0.82 (0.4%) stddev-sans-first:0.83 09:51:36 INFO - PROCESS | 3817 | Values: 197.0 197.0 195.0 197.0 197.0 196.0 196.0 196.0 195.0 197.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.32 (1.4%) stddev-sans-first:0.73 09:51:36 INFO - PROCESS | 3817 | Values: 100.0 96.0 96.0 96.0 97.0 97.0 98.0 96.0 96.0 96.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 09:51:36 INFO - PROCESS | 3817 | Values: 67.0 67.0 67.0 66.0 67.0 71.0 66.0 67.0 69.0 66.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.54 09:51:36 INFO - PROCESS | 3817 | Values: 64.0 64.0 65.0 65.0 65.0 69.0 65.0 65.0 64.0 64.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:5.45 (6.5%) stddev-sans-first:5.59 09:51:36 INFO - PROCESS | 3817 | Values: 81.0 81.0 84.0 90.0 82.0 80.0 83.0 84.0 98.0 86.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:4.67 (3.8%) stddev-sans-first:4.53 09:51:36 INFO - PROCESS | 3817 | Values: 129.0 124.0 117.0 121.0 127.0 123.0 132.0 119.0 124.0 120.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:141.50 stddev:7.84 (5.5%) stddev-sans-first:7.03 09:51:36 INFO - PROCESS | 3817 | Values: 129.0 141.0 142.0 153.0 144.0 139.0 152.0 138.0 141.0 130.0 09:51:36 INFO - PROCESS | 3817 | 09:51:36 INFO - PROCESS | 3817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:2.41 (3.5%) stddev-sans-first:2.35 09:51:36 INFO - PROCESS | 3817 | Values: 65.0 69.0 66.0 68.0 66.0 69.0 68.0 73.0 65.0 68.0 09:51:36 INFO - PROCESS | 3817 | -------- Summary: end -------- 09:51:36 INFO - PROCESS | 3817 | 09:51:37 INFO - TEST-INFO | 3817: exit 0 09:51:37 INFO - TEST-OK | kraken | took 66065ms 09:51:37 INFO - SUITE-END | took 1181s 09:51:38 INFO - Completed test suite (00:19:42) 09:51:38 INFO - javascript benchmark 09:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.973670263297, 2686.5029969455645, 2694.703582605914, 2734.3984323448835, 2740.8903643854246, 4682.110399024183, 4731.266653668678, 4768.666193366465, 4773.976130119345, 4812.181929072058, 4606.700564463316, 4660.440747110351, 4688.156131896258, 4755.762211889409, 4822.662413631038, 4344.804483798229, 4435.68950173488, 4440.97779511102, 4444.97777511112, 4447.84432544861, 422.0955849727798, 4282.14357128574, 4318.9784051079705, 4334.0681753423005, 4402.559744025604, 4268.911427585946, 4288.69979101463, 4319.222539942809, 4332.805023773938, 4390.990072283361, 4293.549177336397, 4322.308430651112, 4330.328799036123, 4345.956540434587, 4382.452193475816, 4329.437173167499, 4349.325854492558, 4355.716878402925, 4382.430284063052, 4398.7580683062415, 4574.130915126116, 4597.448306203243, 4597.816087356502, 4635.721856688576, 4675.251959686468, 4980.8754781130765, 5011.6241281904, 5048.7980480780725, 5059.443461219263, 5060.645754797166, 5096.566791822699, 5104.61715371345, 5111.361079865017, 5129.384473863123, 5145.15105007677, 4750.382450281476, 4793.616510679138, 4794.2089555223, 4801.903961920742, 4847.030593881203, 5147.1507201312115, 5188.766505507186, 5215.374155101412, 5233.188855727369, 5295.761690723926, 4879.072976134523, 4899.510048995072, 4917.065757506062, 4965.82619608312, 4974.1543937530705, 5010.223415370623, 5022.246663000579, 5028.195488721787, 5037.219231019198, 5057.31726216956, 4912.263160525878, 4939.209726443752, 5043.697378157249, 5045.2432135180015, 5050.419201791768, 5003.924941125886, 5059.620528460307, 5067.569256613156, 5070.594352451869, 5091.745412729349, 4271.380649805761, 4272.16692744918, 4283.850065247701, 4317.956820431818, 4320.416743739618, 3666.816659167031, 3678.2091850252323, 3708.666220040155, 3714.817675837325, 3725.6646901778972, 4438.7114837535455, 4440.35614835847, 4466.888327791767, 4498.50516443191, 4550.203714349976, 5106.770195341219, 5154.561862241677, 5155.948440515547, 5156.159242214358, 5210.687358758487, 4381.6494680425485, 4436.223660859337, 4484.686071974996, 4504.909901801946, 4512.097580483916, 4504.301833215857, 4533.886652833706, 4546.65900057497, 4548.7725613719185, 4601.562851529099, 4801.7118972861745, 4813.438055838724, 4825.252085926687, 4831.492693267156, 4864.36763220779, 5057.924131137962, 5073.416557095981, 5112.335396398445, 5135.0, 5152.381714194321, 4771.71369717818, 4817.325574419514, 4835.95164048355, 4843.95156048435, 4865.0, 4938.7530623467965, 4990.700557966534, 4991.226359914219, 4999.800007999639, 4999.900002000012, 5066.113430149635, 5110.923336149886, 5123.87190320245, 5144.845654630367, 5173.094708426086, 5011.0, 5013.974930125326, 5017.84946451607, 5019.146745053276, 5060.8987820242655, 4912.508749125059, 4930.063287975273, 4996.100701873697, 5009.273655320031, 5015.874603134951, 4816.735079570657, 4846.200376937766, 4909.459959404391, 4935.16102262609, 4965.0566392385335, 4975.875603109951, 4989.176785830443, 4990.80036798524, 4992.675476094042, 5019.196928491424, 4824.34871292371, 4862.0, 4866.926996095132, 4887.851354931659, 4891.168501354707], "unit": "score", "name": "dojo.html", "value": 4637.474684579568}, {"lowerIsBetter": false, "replicates": [500.9048280826645, 534.156033467122, 537.3202898333609, 541.9756110975005, 554.9084401073823, 34176.829115854416, 34498.0, 34576.481352779665, 34628.4805727914, 34658.999999999935, 36935.63064369362, 38211.80894095533, 38350.23299534015, 38417.80791096041, 38596.22807543854, 7468.402527797777, 7708.498947568418, 7721.884171737428, 7728.884066739003, 7729.652165652531, 7437.925620743805, 7452.552846829208, 7499.962500187491, 7729.072511298652, 7739.032620922385, 7610.086789585258, 7617.162112167657, 7635.809104772369, 7668.539887606734, 7688.769336919873, 7580.431467639922, 7633.961830190841, 7659.961700191491, 7706.306432421109, 7733.45865789395, 7689.077310722693, 7786.3381612563, 7849.4897831640765, 7870.252326029075, 7879.724209652692, 35685.28629427423, 35944.64055359439, 36032.0, 36102.0, 36190.819045904864, 2670.5460071787843, 2985.880564777406, 3376.763626546143, 3607.3687104756564, 3651.8721844735305, 25368.0, 25699.229023129148, 26139.346516337053, 26263.868680656666, 26310.473790524084, 3324.7672662913606, 3381.1209085637665, 3403.5915690117345, 3407.2504049109157, 3525.682688558042, 164101.0, 165308.0, 166331.99999999878, 166560.16719916323, 166973.0, 42145.78927105406, 42655.36016959748, 54133.0, 54477.0, 54541.0, 43198.0, 44207.55792442099, 44262.778686106365, 44376.11247775026, 44389.0, 14347.92826035884, 14415.78376324356, 14437.855621443861, 14526.564203073925, 14587.562373128823, 10725.51735171919, 10905.890941090645, 10921.617743378943, 10938.343699378063, 10972.177086718528, 14526.636834079232, 14687.118772873662, 14696.55910322692, 14712.779308310384, 14813.629659258604, 6026.728797204137, 6043.428708535725, 6077.604955677867, 6086.2087928569, 6203.596766210182, 853.8121613245077, 861.763015170833, 905.5336501701629, 932.8274269260208, 998.8301988661945, 26132.608010879852, 26440.8677956609, 26955.05657301985, 27043.32391690184, 27174.5923811143, 981.7349315684725, 1001.5593139018808, 1027.814993301198, 1077.4181941751524, 1112.4604566785104, 13858.099223550638, 14033.78949315761, 14203.431862725376, 14252.073615214978, 14280.42878284857, 296469.0, 298632.0, 301230.0, 301850.0, 302719.0, 45568.54431455643, 45735.0, 46193.7690311553, 46428.5357146431, 46675.5332446678, 1167.6672148437824, 1177.8233265010317, 1215.7993931001286, 1231.4520038582746, 1232.1436601562007, 25936.481270374865, 27024.72975270222, 27047.45905081848, 27484.725152748215, 27610.861945690143, 41407.0, 41501.58498414977, 41604.37593436161, 41786.0, 41872.581274186865, 271785.0, 276033.0, 276978.0, 277954.0, 278088.0, 31580.204048131916, 31665.20836979002, 32287.0, 32315.19212019718, 32426.83786581052, 40993.0, 41124.0, 41265.1746965053, 41606.37590436085, 41854.79072604617, 35454.0, 35468.0, 35695.82152089223, 35696.64303356933, 35824.28351433009, 33694.8315258432, 33970.66029339675, 34011.82994085113, 34408.0, 34463.483047753805, 28816.711832881403, 33962.66037339694, 34034.65965340315, 34651.13372165716, 34824.12939676528, 26575.867120664272, 27298.0, 29118.0, 29178.27054323574, 29512.852435737685, 23515.882420587786, 24145.97941854111, 24195.879020604785, 24394.390140246636, 24438.755612444358], "unit": "score", "name": "ext.html", "value": 16500.413148873497}, {"lowerIsBetter": false, "replicates": [343.4144783144738, 351.6624040920714, 357.3014756151723, 360.1410635634012, 360.27764332513306, 15245.39018439261, 15579.298931548079, 16056.839431605695, 16514.669706605862, 16550.089745064015, 15128.16795076273, 15563.0, 16572.0, 16681.49955501334, 16695.165241737926, 4821.13219620469, 4918.163912134945, 5075.898482030358, 5096.872578185556, 5145.382554093514, 5018.222175562793, 5057.367829021372, 5078.136716758141, 5087.414947281073, 5094.083065048289, 5049.772760225798, 5072.2391641253735, 5074.923876141861, 5077.009983053306, 5090.618203634742, 4783.091212669599, 4868.318435419062, 4896.632752543574, 4898.191798353268, 4938.38270216223, 4324.567543245682, 4353.673474489395, 4361.062371590092, 4363.301871700544, 4370.10412865365, 18607.883526988426, 19754.0, 20097.698534521995, 20133.295334663362, 20143.899280503505, 1911.0731295321757, 1924.3457224543722, 1929.488685498344, 2065.824404925583, 2388.773066558674, 8414.495130292202, 12880.227186368847, 13112.47550097995, 13340.666483337896, 13409.128406653535, 1551.6043408930764, 1564.8200456947484, 1591.618011677189, 1609.7504886742574, 1700.5153531243536, 55564.444355556734, 63203.0, 63844.361556384305, 66387.34031649199, 66873.66563167152, 9551.952240238754, 9725.951370243103, 10171.186305095574, 10541.84187237192, 10560.2079844012, 13319.200847949154, 13369.66575835612, 13420.0, 13463.528776492776, 13481.056326057082, 7803.68785248595, 7842.411819113589, 7851.136374998746, 7864.252895974873, 7994.320482759031, 7736.4584479085925, 7737.497062690907, 7774.961125194338, 7805.297523222937, 7850.8429831403055, 4429.402030725811, 4471.485779135441, 4499.932501012488, 4519.480259770103, 4594.88512787183, 1827.15950662694, 1860.135037207705, 1897.8291953723956, 1905.6284024615345, 1919.2418994497095, 796.0964305513285, 825.6449726617612, 865.9177378149066, 872.4808738800403, 907.9773005674779, 13965.58103256904, 15822.05067695942, 15986.0, 16235.350585976665, 16467.917660411862, 899.1278459893892, 904.2314033071967, 904.2359206470522, 941.7033634405141, 947.8151760406655, 9259.953700231456, 9540.189083927806, 9658.9034109658, 9663.806723865484, 9703.17523010552, 407523.0, 424872.0, 426130.0, 429481.0, 429531.0, 70869.29130708627, 72942.63528682322, 73580.63209683917, 73986.0, 75626.24373756192, 912.8539433690711, 915.7390143808982, 920.282179899666, 922.9723108306628, 932.1750251027889, 14612.196329201995, 14800.48198313054, 14973.251337432866, 15080.773788392964, 15136.621584460476, 33392.833035834665, 33678.49482257817, 33822.0, 34028.0, 34589.82705086459, 46037.0, 47443.76278118588, 47664.52335476601, 47734.76132619315, 47889.0, 7402.851942961003, 7571.621418928921, 7582.976298199893, 7585.6965721370525, 7653.311201991847, 10918.890811091787, 11087.889121108685, 11115.499802508744, 11355.261907975955, 11592.1305902056, 9511.61953521879, 9603.327767056518, 9856.753581160528, 9901.702948911545, 9958.502074896081, 8722.476651400937, 10082.747931301776, 10128.34165779222, 10172.898271017195, 10262.43556604394, 9999.400035997864, 10039.69880903574, 10114.393136411838, 10143.188544916242, 10235.948820255851, 7385.409167266498, 7520.135184453858, 7598.506097103671, 7755.844883102193, 7756.767296981099, 8797.956010219908, 9379.718608441757, 9501.192398646193, 9982.201423886218, 10062.798744025225], "unit": "score", "name": "jquery.html", "value": 8062.346353712711}, {"lowerIsBetter": false, "replicates": [1425.3158483927714, 1429.5782744090493, 1595.2183430119237, 1758.894466332021, 1785.482210159054, 6493.805185844432, 6971.477139214554, 7219.711211551538, 7419.295166959137, 7445.627718614068, 7384.22465641108, 7399.223081576424, 7458.030456040707, 7458.105027396707, 7486.850262994737, 2173.0873033326043, 2203.10774136475, 2210.6794514795347, 2211.402921211272, 2234.6759719840616, 2165.981988465419, 2171.272623671072, 2230.8326875484404, 2250.516139030108, 2264.184893438361, 2204.481946742514, 2212.9225477108303, 2231.3752149398197, 2232.9330120096424, 2240.787125223101, 2240.630296001158, 2243.8990245438913, 2252.234240358278, 2253.4929640830765, 2260.9095636174698, 2173.1416090644266, 2177.3903307074042, 2188.4091295350167, 2191.3206905859233, 2200.866553724833, 7455.142658594277, 7530.548167109991, 7549.0, 7618.923810761877, 7662.693492260303, 4592.632589392841, 4690.835820746292, 4692.929606055912, 4702.3181638662545, 4707.929381059253, 2797.8740956656998, 2905.2882043899167, 2948.9705102949124, 2966.896158634459, 2981.8807247710065, 884.5400391796294, 927.6938610258599, 933.5332333833084, 976.4385478349906, 992.9970729563121, 10369.688909332657, 10430.478476076241, 10445.738856528571, 10478.214133939984, 10484.370937743759, 4249.086446414036, 4285.871423857289, 4302.182585308781, 4348.304271316638, 4359.912801743947, 8930.955345223232, 8984.146506081912, 9009.144131307516, 9019.684311049214, 9019.77450563728, 4511.88720281989, 4560.361549383089, 4585.931211031837, 4592.334111553806, 4596.172688916027, 3743.139078012018, 4069.9389509157386, 4077.8368865245056, 4103.035786590149, 4160.417541544186, 3590.5152804371596, 3606.6213047630145, 3690.8892733218045, 3731.4029755239576, 3738.0467980664757, 1179.2511755035614, 1190.6130507584896, 1223.1988047828686, 1226.7178548933616, 1234.9814752778716, 946.3375637054089, 992.4987881119988, 998.3460833154296, 1071.8552995345528, 1246.4515613130193, 7038.2961703829205, 7108.0, 7138.9286107139305, 7156.964215178891, 7160.641967901584, 451.7086479220884, 452.7034792211107, 454.03064457383067, 457.7070674768151, 458.6285109061671, 5377.623566350318, 5444.8094316698725, 5463.399026107125, 5468.152436372368, 5479.315085614298, 8940.597673104727, 9214.308926830514, 9269.536523173814, 9312.860307095263, 9314.673986410444, 8843.115688431106, 9055.773605659911, 9108.8633670495, 9134.22359099484, 9182.081791820765, 6752.5948443093575, 6843.965780171067, 6868.416184624263, 6899.413549848319, 6956.443484521226, 6629.071929929717, 6654.334566543307, 6676.165479315086, 6754.729810807513, 6786.049953006682, 8008.799780005546, 8134.105248422788, 8192.959035204785, 8213.83572328562, 8226.547539885363, 8294.488826271348, 8339.416240863082, 8340.124286949784, 8393.0, 8405.075441701285, 5512.889742205213, 6107.847303817262, 6212.1303017578475, 6571.671416429255, 6704.530682852153, 6936.687849046906, 6948.166220053626, 6963.860722785617, 6990.405815505739, 7004.334588214111, 6276.843078923063, 6307.400796924285, 6356.586821856565, 6372.681365931778, 6391.10524526576, 6236.656983865931, 6265.248170219603, 6313.0, 6385.553011289351, 6416.486681065597, 6508.437974885898, 6700.698468569024, 6704.7988560343265, 6727.293634168537, 6744.7976560703255, 6182.536309776695, 6199.752009919553, 6234.376562343729, 6243.125962365363, 6301.149344838388, 6380.042993551005, 6399.688063946786, 6431.260405053479, 6434.324395938359, 6435.871282574416], "unit": "score", "name": "mootools.html", "value": 4222.033943780227}, {"lowerIsBetter": false, "replicates": [316.22209364962197, 317.4096181103148, 322.92572708277095, 323.10822130918655, 324.67045948362403, 5615.354234263061, 5771.624844385112, 5794.449527294911, 5794.855128621786, 5797.681127537984, 5688.146777983305, 5710.114932185507, 5715.77136914524, 5717.77128914844, 5742.770289188438, 4184.246835569596, 4319.654427645796, 4359.564043595631, 4397.582229688174, 4408.470983481987, 4370.2133615949115, 4373.278409062501, 4375.409319741826, 4385.758783266919, 4385.912281754363, 4350.390945267665, 4351.260285751414, 4359.673024523157, 4367.257566213735, 4368.279233926399, 4309.396684464177, 4328.04782947751, 4347.913041739179, 4372.901007516378, 4375.518692943773, 3800.37293846515, 3800.581935987067, 3803.9619603803885, 3806.3909774435956, 3806.54321481424, 5398.91901621476, 5447.046766815792, 5454.072807622713, 5468.398476167618, 5478.561715062785, 4800.207965685658, 4950.975245123787, 4994.400671919393, 5008.499150084999, 5013.896942672643, 5982.820515384546, 6013.789517366871, 6017.2779266488305, 6021.187139736124, 6028.819135425944, 4101.2207680540605, 4108.506979162519, 4114.280000999813, 4119.526254480713, 4137.0, 6186.133941248228, 6271.34150914152, 6293.402126797947, 6297.2128483939505, 6363.363663633646, 4241.97879010603, 4242.618164365222, 4244.681648876285, 4246.872593822129, 4252.255855225323, 4304.773139655246, 4326.069894972596, 4340.348947657813, 4340.392345071693, 4345.97827010863, 4818.590419814285, 4938.703677779345, 4942.308076869242, 4965.255211718271, 4970.428400733889, 5955.612885162451, 5961.344252132262, 5966.522678185735, 5969.283685957713, 5975.193348897843, 1492.7014597080627, 1497.9325930333162, 1507.6532397548626, 1509.4264179611678, 1509.8641122299045, 953.4001362000248, 972.776261459854, 984.9753756156153, 985.2758222706306, 1006.3710181136789, 5253.684778913277, 5265.078611243017, 5270.077736396115, 5289.550388217045, 5303.973480132575, 6207.34822843604, 6258.718357673915, 6259.530535209787, 6260.749570017239, 6265.404786545362, 5171.01750667372, 5291.3385826771655, 5312.5484333832055, 5332.146856503018, 5339.3058902342445, 3327.8169700666213, 3343.6656334366367, 3373.983130084334, 3415.6755108264674, 3421.7433692473164, 5820.923129221108, 5856.092305692625, 5884.411558844167, 5919.940800592025, 5926.436988486087, 6469.77355792545, 6470.417662410406, 6474.482041436674, 6482.448991835747, 6485.3514648534765, 5830.212921255661, 5830.533557315404, 5903.085021821625, 5939.673317967553, 5943.554233432424, 6028.246469191351, 6218.098375735583, 6276.905846412399, 6283.874322513616, 6291.811245662638, 6206.410391012847, 6212.968935155476, 6291.0, 6291.276503202191, 6302.684865756602, 5816.302043754607, 5825.796097136749, 5947.672877991752, 5960.970195148997, 5962.880742385041, 4145.7719825409895, 4187.0, 4247.87256382309, 4258.87223383299, 4271.996080921043, 6187.16473276102, 6228.972219583718, 6263.091851681572, 6263.718132684131, 6273.498120150468, 5876.294844618673, 6022.247219097613, 6065.636061836304, 6082.330943596289, 6086.360932102066, 6043.607165534227, 6070.3019152798, 6070.362611925861, 6074.483668888017, 6137.232845894263, 5913.822585322448, 5940.673262970578, 5956.0, 5962.0, 5962.0, 5964.642121472725, 6061.272647282354, 6078.5441091919165, 6141.201643786458, 6152.630842149485, 5765.97117014429, 5801.76792928295, 5904.734286957183, 5989.401059893976, 5995.16067750524], "unit": "score", "name": "prototype.html", "value": 4489.978732394813}, {"lowerIsBetter": false, "replicates": [722.4437183368806, 742.7029188324672, 793.9087004994427, 794.2414993681035, 795.6697970342308, 10808.459577021147, 10970.945145274272, 11071.667849964493, 12460.626181214555, 12469.189502682319, 14195.929020354884, 14272.857271427283, 14273.78589321161, 14278.643033924158, 14282.0, 772.4554189296532, 797.8204903896635, 798.4530596541359, 803.4054799448395, 805.4764403137949, 636.5353292096772, 791.268077028749, 799.2367289238792, 802.8193656427286, 804.7384600004992, 823.4770920465518, 839.2237180607943, 844.1474111147724, 845.1084106267884, 846.6867259114106, 802.5906787538369, 827.210014436215, 830.73001274586, 831.9958400208021, 836.2431999040817, 606.169547719627, 614.5053232148119, 621.0497938154631, 627.4415769964735, 627.6767464755654, 12562.74874502514, 12587.874121258761, 12588.496460141583, 12610.873891261153, 12636.0, 12486.375681215994, 12767.0, 12843.422046007952, 12872.22766634005, 13101.606951791366, 8593.871091933626, 8642.697505587274, 8723.38936274461, 8745.256653184488, 8778.868316975251, 3218.8873389431255, 3219.5331676906953, 3239.3360699625173, 3251.658575849549, 3291.391092647868, 43788.781056094835, 44165.0, 44205.77897110526, 44402.33396499023, 44462.77768611169, 10069.194464442828, 10240.334378265388, 10319.896801031893, 10614.0, 10674.78650426987, 17313.04778237209, 17334.133293335282, 17479.737803932952, 17551.91224043897, 17666.734998975026, 6671.33286671329, 6772.424343930821, 6807.21717002551, 6825.658717064127, 6878.896816547755, 3675.852965881335, 3695.060674068081, 3715.7398982070995, 3742.079165896837, 3775.2260786538695, 2633.1310667479684, 2683.5437975544205, 2693.4074503609177, 2698.5682290833374, 2704.0535812465478, 501.8695139263818, 510.4232217594095, 513.3019094032113, 513.6276199755148, 518.7406296851574, 590.6987436407463, 607.1651479216077, 607.5413063137391, 629.5341447328943, 636.8980963045983, 7059.8235044123285, 7433.925660743432, 7473.738419155304, 7530.096388433423, 7708.190639982833, 447.40495141461776, 511.51150651128086, 586.4897539140975, 593.7268856326139, 601.8044135655929, 3456.6543345665737, 3524.1894364296354, 3550.7336949728874, 3556.039869235292, 3611.368010598135, 54955.45044549504, 59135.0, 59710.70144649336, 60148.0, 60283.69858150681, 49320.0, 49893.501064988886, 51056.74471627618, 51806.927722891414, 51941.48058519366, 43372.34941475943, 43694.78152609216, 44084.779576101915, 44398.33402498965, 45066.32400513995, 8165.877511837446, 8552.144785521397, 8687.869681954902, 8830.646774128963, 8969.295833791559, 34737.65262347445, 35322.11694707653, 36048.459273111446, 36368.81815590905, 36713.63286367209, 43781.56218437775, 43814.34278485889, 43959.560404395546, 44062.33906491341, 44543.0, 9856.162226210852, 9949.154321882721, 10378.42918639482, 10610.469476526298, 10717.35695858251, 11860.169788114748, 12061.401317170477, 12384.876151238732, 12478.251304921734, 12524.311162886128, 11759.647210583697, 11873.82189267179, 12219.816702749287, 12385.566505172275, 12480.5007799687, 10962.890371096506, 10975.670729878117, 11427.142964277546, 11601.709957250798, 11722.706932326419, 10426.843597345895, 10926.78146437051, 10964.725881853017, 11170.832437513607, 11322.716932076764, 8962.775930601527, 9000.86498702533, 9013.953119107604, 9555.0, 9600.567974441026, 9378.812423751624, 9448.28378830825, 9500.144986951207, 9932.155766759906, 10065.728638192762], "unit": "score", "name": "yui.html", "value": 6018.733357774123}], "name": "dromaeo_css", "value": 6425.7648760241855}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 113.0, 116.0, 116.0, 127.0, 113.0, 113.0, 113.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 159.0, 173.0, 132.0, 153.0, 158.0, 136.0, 178.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [389.0, 389.0, 392.0, 386.0, 385.0, 388.0, 387.0, 388.0, 387.0, 387.0], "unit": "score", "name": "audio-dft", "value": 387.8}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 77.0, 152.0, 76.0, 76.0, 74.0, 74.0, 153.0, 79.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 94.0, 93.0, 95.0, 151.0, 95.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [197.0, 197.0, 195.0, 197.0, 197.0, 196.0, 196.0, 196.0, 195.0, 197.0], "unit": "score", "name": "imaging-darkroom", "value": 196.3}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 96.0, 96.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 71.0, 66.0, 67.0, 69.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 69.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 84.0, 90.0, 82.0, 80.0, 83.0, 84.0, 98.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 117.0, 121.0, 127.0, 123.0, 132.0, 119.0, 124.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [129.0, 141.0, 142.0, 153.0, 144.0, 139.0, 152.0, 138.0, 141.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 66.0, 68.0, 66.0, 69.0, 68.0, 73.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1814.3999999999999}]} 09:51:38 INFO - Return code: 0 09:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:51:38 ERROR - # TBPL SUCCESS # 09:51:38 INFO - Running post-action listener: _resource_record_post_action 09:51:38 INFO - Running post-run listener: _resource_record_post_run 09:51:39 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 10321920; Write bytes: 457531392; Read time: 2996; Write time: 351852 09:51:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6176768; Read time: 0; Write time: 1988 09:51:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8585216; Write bytes: 451354624; Read time: 2936; Write time: 349864 09:51:39 INFO - Running post-run listener: _upload_blobber_files 09:51:39 INFO - Blob upload gear active. 09:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:51:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:40 INFO - (blobuploader) - INFO - Done attempting. 09:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:41 INFO - (blobuploader) - INFO - Done attempting. 09:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:51:41 INFO - Return code: 0 09:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645ae162610dd55c462fb130a7b1d210fa1348616b1e2ab259d004c1e0e1e035c0797fa73dd3ed22a9443cf38e54dc290117acc31625b49ca100cb0de2542178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/767e944ad9444bea780cd1219a832e7979fa2fa8697d1c873dd1cd10589862d990aba1fa5c6ae692b99054273b9bc8d2c36eeccd395a69b87d428ef775f52900"} 09:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:51:41 INFO - Contents: 09:51:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645ae162610dd55c462fb130a7b1d210fa1348616b1e2ab259d004c1e0e1e035c0797fa73dd3ed22a9443cf38e54dc290117acc31625b49ca100cb0de2542178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/767e944ad9444bea780cd1219a832e7979fa2fa8697d1c873dd1cd10589862d990aba1fa5c6ae692b99054273b9bc8d2c36eeccd395a69b87d428ef775f52900"} 09:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:51:41 INFO - Copying logs to upload dir... 09:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.850505 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-03-14 09:51:41.147355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 09:51:41.151340) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645ae162610dd55c462fb130a7b1d210fa1348616b1e2ab259d004c1e0e1e035c0797fa73dd3ed22a9443cf38e54dc290117acc31625b49ca100cb0de2542178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/767e944ad9444bea780cd1219a832e7979fa2fa8697d1c873dd1cd10589862d990aba1fa5c6ae692b99054273b9bc8d2c36eeccd395a69b87d428ef775f52900"} build_url:https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/V2MY43_ORlKup1FHlnWFTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645ae162610dd55c462fb130a7b1d210fa1348616b1e2ab259d004c1e0e1e035c0797fa73dd3ed22a9443cf38e54dc290117acc31625b49ca100cb0de2542178", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/767e944ad9444bea780cd1219a832e7979fa2fa8697d1c873dd1cd10589862d990aba1fa5c6ae692b99054273b9bc8d2c36eeccd395a69b87d428ef775f52900"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 09:51:41.175509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:51:41.175832) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1457967013.107610-1763403359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 09:51:41.225738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 09:51:41.226057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 09:51:41.226339) ========= ========= Total master_lag: 0.32 =========