builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1450026213.64 results: success (0) buildid: 20151213081631 builduid: 84d766fc302e4b80af67e303b64594ac revision: f561bbb8fd276436255534ec16ad19aaf4f81846 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.644781) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.645345) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.645693) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004843 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.711992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.712327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.770480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.770789) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041141 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.826902) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.827213) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.827669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:33.828041) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-13 09:03:33-- 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% 39.0M=0s 2015-12-13 09:03:34 (39.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.262876 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.109473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.109804) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.106521 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.229962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.230396) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f561bbb8fd276436255534ec16ad19aaf4f81846 --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 f561bbb8fd276436255534ec16ad19aaf4f81846 --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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-13 09:03:34,398 truncating revision to first 12 chars 2015-12-13 09:03:34,398 Setting DEBUG logging. 2015-12-13 09:03:34,398 attempt 1/10 2015-12-13 09:03:34,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f561bbb8fd27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-13 09:03:34,639 unpacking tar archive at: fx-team-f561bbb8fd27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503731 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.747587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.747945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.761755) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.762042) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 09:03:34.762499) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-13 09:03:34.762832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:35 INFO - MultiFileLogger online at 20151213 09:03:35 in /builds/slave/test 09:03:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:03:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:35 INFO - {'append_to_log': False, 09:03:35 INFO - 'base_work_dir': '/builds/slave/test', 09:03:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:03:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:35 INFO - 'branch': 'Fx-Team-Non-PGO', 09:03:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:35 INFO - 'config_files': ('talos/linux_config.py',), 09:03:35 INFO - 'default_actions': ('clobber', 09:03:35 INFO - 'read-buildbot-config', 09:03:35 INFO - 'download-and-extract', 09:03:35 INFO - 'populate-webroot', 09:03:35 INFO - 'create-virtualenv', 09:03:35 INFO - 'install', 09:03:35 INFO - 'run-tests'), 09:03:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:35 INFO - 'download_minidump_stackwalk': True, 09:03:35 INFO - 'download_symbols': 'ondemand', 09:03:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:35 INFO - 'installer_path': 'installer.exe', 09:03:35 INFO - 'log_level': 'info', 09:03:35 INFO - 'log_name': 'talos', 09:03:35 INFO - 'log_to_console': True, 09:03:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:35 INFO - 'opt_config_files': (), 09:03:35 INFO - 'pip_index': False, 09:03:35 INFO - 'sps_profile': False, 09:03:35 INFO - 'sps_profile_interval': 0, 09:03:35 INFO - 'suite': 'dromaeojs', 09:03:35 INFO - 'system_bits': '64', 09:03:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:35 INFO - 'title': 'talos-linux64-ix-060', 09:03:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:35 INFO - 'use_talos_json': True, 09:03:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:35 INFO - 'work_dir': 'build'} 09:03:35 INFO - ##### 09:03:35 INFO - ##### Running clobber step. 09:03:35 INFO - ##### 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: clobber 09:03:35 INFO - rmtree: /builds/slave/test/build 09:03:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:36 INFO - Running post-action listener: _resource_record_post_action 09:03:36 INFO - ##### 09:03:36 INFO - ##### Running read-buildbot-config step. 09:03:36 INFO - ##### 09:03:36 INFO - Running pre-action listener: _resource_record_pre_action 09:03:36 INFO - Running main action method: read_buildbot_config 09:03:36 INFO - Using buildbot properties: 09:03:36 INFO - { 09:03:36 INFO - "properties": { 09:03:36 INFO - "buildnumber": 1009, 09:03:36 INFO - "product": "firefox", 09:03:36 INFO - "script_repo_revision": "production", 09:03:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:03:36 INFO - "repository": "", 09:03:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:03:36 INFO - "buildid": "20151213081631", 09:03:36 INFO - "slavename": "talos-linux64-ix-060", 09:03:36 INFO - "pgo_build": "False", 09:03:36 INFO - "basedir": "/builds/slave/test", 09:03:36 INFO - "project": "", 09:03:36 INFO - "platform": "ubuntu64_hw", 09:03:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:03:36 INFO - "slavebuilddir": "test", 09:03:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:03:36 INFO - "branch": "fx-team", 09:03:36 INFO - "repo_path": "integration/fx-team", 09:03:36 INFO - "stage_platform": "linux64", 09:03:36 INFO - "builduid": "84d766fc302e4b80af67e303b64594ac", 09:03:36 INFO - "revision": "f561bbb8fd276436255534ec16ad19aaf4f81846" 09:03:36 INFO - }, 09:03:36 INFO - "sourcestamp": { 09:03:36 INFO - "repository": "", 09:03:36 INFO - "hasPatch": false, 09:03:36 INFO - "project": "", 09:03:36 INFO - "branch": "fx-team-linux64-talos", 09:03:36 INFO - "changes": [ 09:03:36 INFO - { 09:03:36 INFO - "category": null, 09:03:36 INFO - "files": [ 09:03:36 INFO - { 09:03:36 INFO - "url": null, 09:03:36 INFO - "name": "https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:03:36 INFO - } 09:03:36 INFO - ], 09:03:36 INFO - "repository": "", 09:03:36 INFO - "rev": "f561bbb8fd276436255534ec16ad19aaf4f81846", 09:03:36 INFO - "who": "ryanvm@gmail.com", 09:03:36 INFO - "when": 1450026182, 09:03:36 INFO - "number": 7355716, 09:03:36 INFO - "comments": "Bug 1232196 - Update pdf.js to version 1.3.76. r=bdahl", 09:03:36 INFO - "project": "", 09:03:36 INFO - "at": "Sun 13 Dec 2015 09:03:02", 09:03:36 INFO - "branch": "fx-team-linux64-talos", 09:03:36 INFO - "revlink": "", 09:03:36 INFO - "properties": [ 09:03:36 INFO - [ 09:03:36 INFO - "buildid", 09:03:36 INFO - "20151213081631", 09:03:36 INFO - "Change" 09:03:36 INFO - ], 09:03:36 INFO - [ 09:03:36 INFO - "builduid", 09:03:36 INFO - "84d766fc302e4b80af67e303b64594ac", 09:03:36 INFO - "Change" 09:03:36 INFO - ], 09:03:36 INFO - [ 09:03:36 INFO - "pgo_build", 09:03:36 INFO - "False", 09:03:36 INFO - "Change" 09:03:36 INFO - ] 09:03:36 INFO - ], 09:03:36 INFO - "revision": "f561bbb8fd276436255534ec16ad19aaf4f81846" 09:03:36 INFO - } 09:03:36 INFO - ], 09:03:36 INFO - "revision": "f561bbb8fd276436255534ec16ad19aaf4f81846" 09:03:36 INFO - } 09:03:36 INFO - } 09:03:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:03:36 INFO - Running post-action listener: _resource_record_post_action 09:03:36 INFO - ##### 09:03:36 INFO - ##### Running download-and-extract step. 09:03:36 INFO - ##### 09:03:36 INFO - Running pre-action listener: _resource_record_pre_action 09:03:36 INFO - Running main action method: download_and_extract 09:03:36 INFO - mkdir: /builds/slave/test/build/tests 09:03:36 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:03:36 INFO - https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/test_packages.json 09:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/test_packages.json 09:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:03:37 INFO - Downloaded 1302 bytes. 09:03:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:03:37 INFO - Using the following test package requirements: 09:03:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'jsshell-linux-x86_64.zip'], 09:03:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:03:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:03:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:37 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:03:37 INFO - https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:39 INFO - Downloaded 21869834 bytes. 09:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:03:40 INFO - Return code: 0 09:03:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:03:40 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:03:40 INFO - https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:45 INFO - Downloaded 21869834 bytes. 09:03:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:03:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:03:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:03:47 INFO - Return code: 0 09:03:47 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:03:47 INFO - https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:03:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:03:48 INFO - Downloaded 11132038 bytes. 09:03:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:03:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:03:48 INFO - Return code: 0 09:03: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:03:48 INFO - https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:03:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:03:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:03:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:03:49 INFO - Downloaded 57744091 bytes. 09:03:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:03:49 INFO - mkdir: /builds/slave/test/properties 09:03:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:49 INFO - Contents: 09:03:49 INFO - build_url:https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:03:49 INFO - Running post-action listener: _resource_record_post_action 09:03:49 INFO - Running post-action listener: set_extra_try_arguments 09:03:49 INFO - ##### 09:03:49 INFO - ##### Running populate-webroot step. 09:03:49 INFO - ##### 09:03:49 INFO - Running pre-action listener: _resource_record_pre_action 09:03:49 INFO - Running main action method: populate_webroot 09:03:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:49 INFO - '--tppagecycles', 09:03:49 INFO - '7'], 09:03:49 INFO - 'tests': ['tsvgm']}}, 09:03:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:03:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:03:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:03:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['damp', 'tps']}, 09:03:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['damp', 'tps']}, 09:03:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:03:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:49 INFO - 'other': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'other_l64': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'other_nol64': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore']}, 09:03:49 INFO - 'svgr': {'tests': ['tsvgx', 09:03:49 INFO - 'tsvgr_opacity', 09:03:49 INFO - 'tart', 09:03:49 INFO - 'tscrollx', 09:03:49 INFO - 'cart']}, 09:03:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['tsvgx', 09:03:49 INFO - 'tsvgr_opacity', 09:03:49 INFO - 'tart', 09:03:49 INFO - 'tscrollx', 09:03:49 INFO - 'cart']}, 09:03:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['tp5o']}, 09:03:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--e10s'], 09:03:49 INFO - 'tests': ['tp5o']}, 09:03:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--xperf_path', 09:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:49 INFO - 'tests': ['tp5n']}, 09:03:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--e10s', 09:03:49 INFO - '--xperf_path', 09:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:49 INFO - 'tests': ['tp5n']}}, 09:03:49 INFO - 'talos.zip': {'path': '', 09:03:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:49 INFO - Running post-action listener: _resource_record_post_action 09:03:49 INFO - ##### 09:03:49 INFO - ##### Running create-virtualenv step. 09:03:49 INFO - ##### 09:03:49 INFO - Running pre-action listener: _resource_record_pre_action 09:03:49 INFO - Running main action method: create_virtualenv 09:03:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:49 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:03:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:49 INFO - Using real prefix '/usr' 09:03:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:53 INFO - Installing pip.................done. 09:03:53 INFO - Return code: 0 09:03:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:53 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:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 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:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:53 INFO - Using env: {'DISPLAY': ':0', 09:03:53 INFO - 'HOME': '/home/cltbld', 09:03:53 INFO - 'LANG': 'en_US.UTF-8', 09:03:53 INFO - 'LANGUAGE': 'en_US:en', 09:03:53 INFO - 'LOGNAME': 'cltbld', 09:03:53 INFO - 'MAIL': '/var/mail/cltbld', 09:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:53 INFO - 'MOZ_NO_REMOTE': '1', 09:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:53 INFO - 'NO_EM_RESTART': '1', 09:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:53 INFO - 'PWD': '/builds/slave/test', 09:03:53 INFO - 'SHELL': '/bin/bash', 09:03:53 INFO - 'SHLVL': '1', 09:03:53 INFO - 'TERM': 'linux', 09:03:53 INFO - 'TMOUT': '86400', 09:03:53 INFO - 'USER': 'cltbld', 09:03:53 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:53 INFO - '_': '/tools/buildbot/bin/python'} 09:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:53 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:03:53 INFO - Cleaning up... 09:03:53 INFO - Return code: 0 09:03:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:03:53 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:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 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:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:53 INFO - Using env: {'DISPLAY': ':0', 09:03:53 INFO - 'HOME': '/home/cltbld', 09:03:53 INFO - 'LANG': 'en_US.UTF-8', 09:03:53 INFO - 'LANGUAGE': 'en_US:en', 09:03:53 INFO - 'LOGNAME': 'cltbld', 09:03:53 INFO - 'MAIL': '/var/mail/cltbld', 09:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:53 INFO - 'MOZ_NO_REMOTE': '1', 09:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:53 INFO - 'NO_EM_RESTART': '1', 09:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:53 INFO - 'PWD': '/builds/slave/test', 09:03:53 INFO - 'SHELL': '/bin/bash', 09:03:53 INFO - 'SHLVL': '1', 09:03:53 INFO - 'TERM': 'linux', 09:03:53 INFO - 'TMOUT': '86400', 09:03:53 INFO - 'USER': 'cltbld', 09:03:53 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:53 INFO - '_': '/tools/buildbot/bin/python'} 09:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:53 INFO - Downloading/unpacking psutil>=0.7.1 09:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:03:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:55 INFO - Installing collected packages: psutil 09:03:55 INFO - Running setup.py install for psutil 09:03:55 INFO - building 'psutil._psutil_linux' extension 09:03:55 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:03:56 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:03:57 INFO - building 'psutil._psutil_posix' extension 09:03:57 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:03:57 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:03:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:57 INFO - Successfully installed psutil 09:03:57 INFO - Cleaning up... 09:03:57 INFO - Return code: 0 09:03:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:03:57 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:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:57 INFO - Using env: {'DISPLAY': ':0', 09:03:57 INFO - 'HOME': '/home/cltbld', 09:03:57 INFO - 'LANG': 'en_US.UTF-8', 09:03:57 INFO - 'LANGUAGE': 'en_US:en', 09:03:57 INFO - 'LOGNAME': 'cltbld', 09:03:57 INFO - 'MAIL': '/var/mail/cltbld', 09:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:57 INFO - 'MOZ_NO_REMOTE': '1', 09:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:57 INFO - 'NO_EM_RESTART': '1', 09:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:57 INFO - 'PWD': '/builds/slave/test', 09:03:57 INFO - 'SHELL': '/bin/bash', 09:03:57 INFO - 'SHLVL': '1', 09:03:57 INFO - 'TERM': 'linux', 09:03:57 INFO - 'TMOUT': '86400', 09:03:57 INFO - 'USER': 'cltbld', 09:03:57 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:57 INFO - '_': '/tools/buildbot/bin/python'} 09:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:03:57 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:03:57 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:03:57 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:03:57 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:03:57 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:03:57 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:03:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:59 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:03:59 INFO - Installing collected packages: mozsystemmonitor 09:03:59 INFO - Running setup.py install for mozsystemmonitor 09:03:59 INFO - Successfully installed mozsystemmonitor 09:03:59 INFO - Cleaning up... 09:03:59 INFO - Return code: 0 09:03:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:59 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:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:59 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:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:59 INFO - Using env: {'DISPLAY': ':0', 09:03:59 INFO - 'HOME': '/home/cltbld', 09:03:59 INFO - 'LANG': 'en_US.UTF-8', 09:03:59 INFO - 'LANGUAGE': 'en_US:en', 09:03:59 INFO - 'LOGNAME': 'cltbld', 09:03:59 INFO - 'MAIL': '/var/mail/cltbld', 09:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:59 INFO - 'MOZ_NO_REMOTE': '1', 09:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:59 INFO - 'NO_EM_RESTART': '1', 09:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:59 INFO - 'PWD': '/builds/slave/test', 09:03:59 INFO - 'SHELL': '/bin/bash', 09:03:59 INFO - 'SHLVL': '1', 09:03:59 INFO - 'TERM': 'linux', 09:03:59 INFO - 'TMOUT': '86400', 09:03:59 INFO - 'USER': 'cltbld', 09:03:59 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:59 INFO - '_': '/tools/buildbot/bin/python'} 09:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:04:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 INFO - Downloading docopt-0.6.1.tar.gz 09:04:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:02 INFO - Running setup.py install for blobuploader 09:04:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:02 INFO - Running setup.py install for requests 09:04:02 INFO - Running setup.py install for docopt 09:04:02 INFO - Successfully installed blobuploader requests docopt 09:04:02 INFO - Cleaning up... 09:04:02 INFO - Return code: 0 09:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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:04:02 INFO - Using env: {'DISPLAY': ':0', 09:04:02 INFO - 'HOME': '/home/cltbld', 09:04:02 INFO - 'LANG': 'en_US.UTF-8', 09:04:02 INFO - 'LANGUAGE': 'en_US:en', 09:04:02 INFO - 'LOGNAME': 'cltbld', 09:04:02 INFO - 'MAIL': '/var/mail/cltbld', 09:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:02 INFO - 'MOZ_NO_REMOTE': '1', 09:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:02 INFO - 'NO_EM_RESTART': '1', 09:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:02 INFO - 'PWD': '/builds/slave/test', 09:04:02 INFO - 'SHELL': '/bin/bash', 09:04:02 INFO - 'SHLVL': '1', 09:04:02 INFO - 'TERM': 'linux', 09:04:02 INFO - 'TMOUT': '86400', 09:04:02 INFO - 'USER': 'cltbld', 09:04:02 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:02 INFO - '_': '/tools/buildbot/bin/python'} 09:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:03 INFO - Running setup.py (path:/tmp/pip-63n9ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:03 INFO - Running setup.py (path:/tmp/pip-Fox5pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:03 INFO - Running setup.py (path:/tmp/pip-N_HIbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:03 INFO - Running setup.py (path:/tmp/pip-LLeT9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:03 INFO - Running setup.py (path:/tmp/pip-7Mtd1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:03 INFO - Running setup.py (path:/tmp/pip-BSKDP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:03 INFO - Running setup.py (path:/tmp/pip-s_OkaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:03 INFO - Running setup.py (path:/tmp/pip-gzFxE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:03 INFO - Running setup.py (path:/tmp/pip-tCulfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:03 INFO - Running setup.py (path:/tmp/pip-RyCX1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:03 INFO - Running setup.py (path:/tmp/pip-jrtLBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:03 INFO - Running setup.py (path:/tmp/pip-nzHUxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:04 INFO - Running setup.py (path:/tmp/pip-nSyES7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:04 INFO - Running setup.py (path:/tmp/pip-l0XsIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:04 INFO - Running setup.py (path:/tmp/pip-G5I1sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:04 INFO - Running setup.py (path:/tmp/pip-Kjw4eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:04 INFO - Running setup.py (path:/tmp/pip-VcMX8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:04 INFO - Running setup.py install for manifestparser 09:04:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:04 INFO - Running setup.py install for mozcrash 09:04:04 INFO - Running setup.py install for mozdebug 09:04:04 INFO - Running setup.py install for mozdevice 09:04:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:04 INFO - Running setup.py install for mozfile 09:04:04 INFO - Running setup.py install for mozhttpd 09:04:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozinfo 09:04:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozInstall 09:04:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozleak 09:04:05 INFO - Running setup.py install for mozlog 09:04:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for moznetwork 09:04:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozprocess 09:04:05 INFO - Running setup.py install for mozprofile 09:04:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozrunner 09:04:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozscreenshot 09:04:05 INFO - Running setup.py install for moztest 09:04:06 INFO - Running setup.py install for mozversion 09:04:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:06 INFO - Cleaning up... 09:04:06 INFO - Return code: 0 09:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:06 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:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:06 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:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:04:06 INFO - Using env: {'DISPLAY': ':0', 09:04:06 INFO - 'HOME': '/home/cltbld', 09:04:06 INFO - 'LANG': 'en_US.UTF-8', 09:04:06 INFO - 'LANGUAGE': 'en_US:en', 09:04:06 INFO - 'LOGNAME': 'cltbld', 09:04:06 INFO - 'MAIL': '/var/mail/cltbld', 09:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:06 INFO - 'MOZ_NO_REMOTE': '1', 09:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:06 INFO - 'NO_EM_RESTART': '1', 09:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:06 INFO - 'PWD': '/builds/slave/test', 09:04:06 INFO - 'SHELL': '/bin/bash', 09:04:06 INFO - 'SHLVL': '1', 09:04:06 INFO - 'TERM': 'linux', 09:04:06 INFO - 'TMOUT': '86400', 09:04:06 INFO - 'USER': 'cltbld', 09:04:06 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:06 INFO - '_': '/tools/buildbot/bin/python'} 09:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:06 INFO - Running setup.py (path:/tmp/pip-JSyWHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:06 INFO - Running setup.py (path:/tmp/pip-1kPE_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:06 INFO - Running setup.py (path:/tmp/pip-bz19CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:06 INFO - Running setup.py (path:/tmp/pip-DuDN5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:06 INFO - Running setup.py (path:/tmp/pip-ewaaID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:06 INFO - Running setup.py (path:/tmp/pip-W7v4gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:06 INFO - Running setup.py (path:/tmp/pip-ae4Q_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:06 INFO - Running setup.py (path:/tmp/pip-rmIxVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:06 INFO - Running setup.py (path:/tmp/pip-5fsJpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:07 INFO - Running setup.py (path:/tmp/pip-5fbBCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:07 INFO - Running setup.py (path:/tmp/pip-f072bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:07 INFO - Running setup.py (path:/tmp/pip-PB9YjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:07 INFO - Running setup.py (path:/tmp/pip-wNNZla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:07 INFO - Running setup.py (path:/tmp/pip-oyQCji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:07 INFO - Running setup.py (path:/tmp/pip-i3YvVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:07 INFO - Running setup.py (path:/tmp/pip-SrgE2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:07 INFO - Running setup.py (path:/tmp/pip-HgsQnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:07 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:04:07 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:04:07 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:04:07 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:04:07 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:04:07 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:04:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:09 INFO - Downloading blessings-1.5.1.tar.gz 09:04:09 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:09 INFO - Installing collected packages: blessings 09:04:09 INFO - Running setup.py install for blessings 09:04:09 INFO - Successfully installed blessings 09:04:09 INFO - Cleaning up... 09:04:09 INFO - Return code: 0 09:04:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:09 INFO - Reading from file tmpfile_stdout 09:04:09 INFO - Current package versions: 09:04:09 INFO - argparse == 1.2.1 09:04:09 INFO - blessings == 1.5.1 09:04:09 INFO - blobuploader == 1.2.4 09:04:09 INFO - docopt == 0.6.1 09:04:09 INFO - manifestparser == 1.1 09:04:09 INFO - mozInstall == 1.12 09:04:09 INFO - mozcrash == 0.16 09:04:09 INFO - mozdebug == 0.1 09:04:09 INFO - mozdevice == 0.47 09:04:09 INFO - mozfile == 1.2 09:04:09 INFO - mozhttpd == 0.7 09:04:09 INFO - mozinfo == 0.9 09:04:09 INFO - mozleak == 0.1 09:04:09 INFO - mozlog == 3.1 09:04:09 INFO - moznetwork == 0.27 09:04:09 INFO - mozprocess == 0.22 09:04:09 INFO - mozprofile == 0.27 09:04:09 INFO - mozrunner == 6.11 09:04:09 INFO - mozscreenshot == 0.1 09:04:09 INFO - mozsystemmonitor == 0.0 09:04:09 INFO - moztest == 0.7 09:04:09 INFO - mozversion == 1.4 09:04:09 INFO - psutil == 3.1.1 09:04:09 INFO - requests == 1.2.3 09:04:09 INFO - wsgiref == 0.1.2 09:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:04:09 INFO - Using env: {'DISPLAY': ':0', 09:04:09 INFO - 'HOME': '/home/cltbld', 09:04:09 INFO - 'LANG': 'en_US.UTF-8', 09:04:09 INFO - 'LANGUAGE': 'en_US:en', 09:04:09 INFO - 'LOGNAME': 'cltbld', 09:04:09 INFO - 'MAIL': '/var/mail/cltbld', 09:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:09 INFO - 'MOZ_NO_REMOTE': '1', 09:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:09 INFO - 'NO_EM_RESTART': '1', 09:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:09 INFO - 'PWD': '/builds/slave/test', 09:04:09 INFO - 'SHELL': '/bin/bash', 09:04:09 INFO - 'SHLVL': '1', 09:04:09 INFO - 'TERM': 'linux', 09:04:09 INFO - 'TMOUT': '86400', 09:04:09 INFO - 'USER': 'cltbld', 09:04:09 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:09 INFO - '_': '/tools/buildbot/bin/python'} 09:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:09 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 1)) 09:04:09 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 2)) 09:04:09 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 3)) 09:04:09 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 4)) 09:04:09 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 5)) 09:04:09 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 6)) 09:04:09 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 7)) 09:04:09 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 8)) 09:04:09 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:04:09 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 3)) 09:04:09 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:04:09 INFO - Cleaning up... 09:04:09 INFO - Return code: 0 09:04:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04: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:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:04:09 INFO - Using env: {'DISPLAY': ':0', 09:04:09 INFO - 'HOME': '/home/cltbld', 09:04:09 INFO - 'LANG': 'en_US.UTF-8', 09:04:09 INFO - 'LANGUAGE': 'en_US:en', 09:04:09 INFO - 'LOGNAME': 'cltbld', 09:04:09 INFO - 'MAIL': '/var/mail/cltbld', 09:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:09 INFO - 'MOZ_NO_REMOTE': '1', 09:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:09 INFO - 'NO_EM_RESTART': '1', 09:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:09 INFO - 'PWD': '/builds/slave/test', 09:04:09 INFO - 'SHELL': '/bin/bash', 09:04:09 INFO - 'SHLVL': '1', 09:04:09 INFO - 'TERM': 'linux', 09:04:09 INFO - 'TMOUT': '86400', 09:04:09 INFO - 'USER': 'cltbld', 09:04:09 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:09 INFO - '_': '/tools/buildbot/bin/python'} 09:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:10 INFO - Downloading/unpacking jsonschema 09:04:10 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:04:10 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:04:10 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:04:10 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:04:10 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:04:10 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:04:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:04:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:12 INFO - warning: no files found matching '*.txt' 09:04:12 INFO - no previously-included directories found matching 'build' 09:04:12 INFO - no previously-included directories found matching 'dist' 09:04:12 INFO - no previously-included directories found matching '.git*' 09:04:12 INFO - Installing collected packages: jsonschema, functools32 09:04:12 INFO - Running setup.py install for functools32 09:04:12 INFO - warning: no files found matching '*.txt' 09:04:12 INFO - no previously-included directories found matching 'build' 09:04:12 INFO - no previously-included directories found matching 'dist' 09:04:12 INFO - no previously-included directories found matching '.git*' 09:04:12 INFO - Successfully installed jsonschema functools32 09:04:12 INFO - Cleaning up... 09:04:12 INFO - Return code: 0 09:04:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:04:12 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:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 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:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f0ac6577f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', '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:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:04:12 INFO - Using env: {'DISPLAY': ':0', 09:04:12 INFO - 'HOME': '/home/cltbld', 09:04:12 INFO - 'LANG': 'en_US.UTF-8', 09:04:12 INFO - 'LANGUAGE': 'en_US:en', 09:04:12 INFO - 'LOGNAME': 'cltbld', 09:04:12 INFO - 'MAIL': '/var/mail/cltbld', 09:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:12 INFO - 'MOZ_NO_REMOTE': '1', 09:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:12 INFO - 'NO_EM_RESTART': '1', 09:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:12 INFO - 'PWD': '/builds/slave/test', 09:04:12 INFO - 'SHELL': '/bin/bash', 09:04:12 INFO - 'SHLVL': '1', 09:04:12 INFO - 'TERM': 'linux', 09:04:12 INFO - 'TMOUT': '86400', 09:04:12 INFO - 'USER': 'cltbld', 09:04:12 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:12 INFO - '_': '/tools/buildbot/bin/python'} 09:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:12 INFO - Downloading/unpacking flake8 09:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:04:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:04:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:04:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:14 INFO - no previously-included directories found matching 'docs/_build' 09:04:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:14 INFO - Running setup.py install for pep8 09:04:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:15 INFO - no previously-included directories found matching 'docs/_build' 09:04:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:04:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:15 INFO - Cleaning up... 09:04:15 INFO - Return code: 0 09:04:15 INFO - Running post-action listener: _resource_record_post_action 09:04:15 INFO - Running post-action listener: _start_resource_monitoring 09:04:15 INFO - Starting resource monitoring. 09:04:15 INFO - ##### 09:04:15 INFO - ##### Running install step. 09:04:15 INFO - ##### 09:04:15 INFO - Running pre-action listener: _resource_record_pre_action 09:04:15 INFO - Running main action method: install 09:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:15 INFO - Reading from file tmpfile_stdout 09:04:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:15 INFO - Reading from file tmpfile_stdout 09:04:15 INFO - Output received: 09:04:15 INFO - Usage: mozinstall [options] installer 09:04:15 INFO - Options: 09:04:15 INFO - -h, --help show this help message and exit 09:04:15 INFO - -d DEST, --destination=DEST 09:04:15 INFO - Directory to install application into. [default: 09:04:15 INFO - "/builds/slave/test"] 09:04:15 INFO - --app=APP Application being installed. [default: firefox] 09:04:15 INFO - mkdir: /builds/slave/test/build/application 09:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:04:29 INFO - Reading from file tmpfile_stdout 09:04:29 INFO - Output received: 09:04:29 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - ##### 09:04:29 INFO - ##### Running run-tests step. 09:04:29 INFO - ##### 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: run_tests 09:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:29 INFO - Python 2.7.3 09:04:29 INFO - Return code: 0 09:04:29 INFO - grabbing minidump binary from tooltool 09:04:29 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:04:29 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 0x1a730b0>, '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 0x1a73fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:29 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:04:29 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:04:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:30 INFO - Return code: 0 09:04:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:04:31 INFO - Return code: 0 09:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test/build 09:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 09:04:31 INFO - Using env: {'DISPLAY': ':0', 09:04:31 INFO - 'HOME': '/home/cltbld', 09:04:31 INFO - 'LANG': 'en_US.UTF-8', 09:04:31 INFO - 'LANGUAGE': 'en_US:en', 09:04:31 INFO - 'LOGNAME': 'cltbld', 09:04:31 INFO - 'MAIL': '/var/mail/cltbld', 09:04:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:31 INFO - 'MOZ_NO_REMOTE': '1', 09:04:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:31 INFO - 'NO_EM_RESTART': '1', 09:04:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:31 INFO - 'PWD': '/builds/slave/test', 09:04:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:31 INFO - 'SHELL': '/bin/bash', 09:04:31 INFO - 'SHLVL': '1', 09:04:31 INFO - 'TERM': 'linux', 09:04:31 INFO - 'TMOUT': '86400', 09:04:31 INFO - 'USER': 'cltbld', 09:04:31 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559', 09:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:31 INFO - '_': '/tools/buildbot/bin/python'} 09:04:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 09:04:31 INFO - mozversion INFO | application_buildid: 20151213081631 09:04:31 INFO - mozversion INFO | application_changeset: f561bbb8fd276436255534ec16ad19aaf4f81846 09:04:31 INFO - mozversion INFO | application_display_name: Nightly 09:04:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:31 INFO - mozversion INFO | application_name: Firefox 09:04:31 INFO - mozversion INFO | application_remotingname: firefox 09:04:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:04:31 INFO - mozversion INFO | application_vendor: Mozilla 09:04:31 INFO - mozversion INFO | application_version: 45.0a1 09:04:31 INFO - mozversion INFO | platform_buildid: 20151213081631 09:04:31 INFO - mozversion INFO | platform_changeset: f561bbb8fd276436255534ec16ad19aaf4f81846 09:04:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:04:31 INFO - mozversion INFO | platform_version: 45.0a1 09:04:31 INFO - 2015-12-13 09:04:31,451 DEBUG : using testdate: 1450026271 09:04:31 INFO - 2015-12-13 09:04:31,451 DEBUG : actual date: 1450026271 09:04:31 INFO - 2015-12-13 09:04:31,547 INFO : starting webserver on 'localhost:40262' 09:04:31 INFO - 2015-12-13 09:04:31,548 INFO : Starting test suite talos-linux64-ix-060 09:04:31 INFO - 2015-12-13 09:04:31,548 INFO : Starting test dromaeo_css 09:04:31 INFO - 2015-12-13 09:04:31,548 DEBUG : operating with platform_type : linux_ 09:04:31 INFO - 2015-12-13 09:04:31,549 INFO : Initialising browser for dromaeo_css test... 09:04:31 INFO - 2015-12-13 09:04:31,581 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ1a7AN/profile http://localhost:40262/getInfo.html 09:04:38 INFO - 2015-12-13 09:04:38,319 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:04:38 INFO - 2015-12-13 09:04:38,319 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:04:38 INFO - 2015-12-13 09:04:38,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:04:38 INFO - 2015-12-13 09:04:38,319 DEBUG : BROWSER_OUTPUT: __metrics 09:04:38 INFO - 2015-12-13 09:04:38,476 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:04:38 INFO - 2015-12-13 09:04:38,544 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:39 INFO - 2015-12-13 09:04:39,797 INFO : Browser initialized. 09:04:39 INFO - 2015-12-13 09:04:39,798 INFO : Running cycle 1/1 for dromaeo_css test... 09:04:39 INFO - 2015-12-13 09:04:39,798 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ1a7AN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:04:51 INFO - 2015-12-13 09:04:51,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 143290368 09:04:51 INFO - 2015-12-13 09:04:51,793 DEBUG : BROWSER_OUTPUT: 09:05:43 INFO - 2015-12-13 09:05:43,410 DEBUG : BROWSER_OUTPUT: 1450026343404 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:07:55 INFO - 2015-12-13 09:07:55,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40262/tests/dromaeo/cssquery-ext.html) 09:07:56 INFO - 2015-12-13 09:07:56,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 241291264 09:07:56 INFO - 2015-12-13 09:07:56,652 DEBUG : BROWSER_OUTPUT: 09:10:59 INFO - 2015-12-13 09:10:59,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-ext.html (next: http://localhost:40262/tests/dromaeo/cssquery-jquery.html) 09:10:59 INFO - 2015-12-13 09:10:59,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 221421568 09:10:59 INFO - 2015-12-13 09:10:59,605 DEBUG : BROWSER_OUTPUT: 09:14:01 INFO - 2015-12-13 09:14:01,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40262/tests/dromaeo/cssquery-mootools.html) 09:14:02 INFO - 2015-12-13 09:14:02,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 227237888 09:14:02 INFO - 2015-12-13 09:14:02,217 DEBUG : BROWSER_OUTPUT: 09:17:04 INFO - 2015-12-13 09:17:04,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40262/tests/dromaeo/cssquery-prototype.html) 09:17:04 INFO - 2015-12-13 09:17:04,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 206802944 09:17:04 INFO - 2015-12-13 09:17:04,764 DEBUG : BROWSER_OUTPUT: 09:20:07 INFO - 2015-12-13 09:20:07,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40262/tests/dromaeo/cssquery-yui.html) 09:20:08 INFO - 2015-12-13 09:20:08,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 207572992 09:20:08 INFO - 2015-12-13 09:20:08,105 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/dromaeo/cssquery-yui.html (next: http://localhost:40262/tests/dromaeo/cssquery-dojo.html) 09:23:10 INFO - 2015-12-13 09:23:10,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 253054976 09:23:10 INFO - 2015-12-13 09:23:10,835 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,835 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:23:10 INFO - 2015-12-13 09:23:10,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:23:10 INFO - 2015-12-13 09:23:10,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:23:10 INFO - 2015-12-13 09:23:10,835 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:23:10 INFO - 2015-12-13 09:23:10,837 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.301909993852;2701.918942431728;2711.4170453352526;2719.360950176709;2736.179146256123;4419.359192917033;4570.725756454607;4683.882902927428;4719.056188762244;4725.810967561298;4594.150082234789;4599.494055653875;4606.424196975378;4622.630189584834;4789.4731579526315;4242.809073591696;4268.231718290706;4289.8498552550745;4350.499692535352;4374.584414480635;4277.914441711164;4355.7604331761895;4381.627561657263;4382.7589482578605;4436.44544431946;4107.199096176247;4201.894952626179;4222.978885105555;4359.782010899474;4376.102898905717;4354.194474022316;4358.106588149421;4370.060437006027;4382.948092457787;4400.515943246241;4348.7390756554705;4365.083332500179;4365.80353884076;4369.1480161368545;4386.736795792231;4398.450193725752;4469.553044695537;4513.368128462018;4515.209838278321;4577.382053422779;5073.898522029575;5081.136206844845;5084.389873215201;5085.135526960388;5130.640855140142;5110.28456016158;5113.769880355356;5114.2584325273;5120.513551212629;5153.2785410042625;4502.234620114556;4521.796519156645;4625.629949604024;4630.536946305342;4728.692634978785;5156.639035267495;5275.630705850554;5275.762590683428;5276.445973172762;5321.015612111694;5054.747262636927;5065.290859279704;5073.086844368049;5073.695578265316;5124.077666020077;4754.7147171169845;4877.902441951142;4882.462929077869;4993.525615066563;5068.214426763858;4881.389826271716;4885.8045678173185;4885.9022819544125;4906.754662266872;4927.556519913225;4854.441739200037;4858.1012512685265;4863.708177509361;4874.268859671078;4911.386076740408;4004.8998775030273;4048.149888523443;4104.733192342488;4111.8972025699595;4135.98668326262;3645.2527231917393;3651.817409129586;3682.5028621135802;3692.7230457715777;3729.291434627412;4315.136972605492;4324.783760811947;4327.221100201994;4366.607005369532;4367;4843.418789745253;4972.8508144755715;4975.726335051607;5002.52476014778;5036.244563315458;4248.852809741353;4316.482022157361;4341.522432532419;4379.430674012358;4411.735295882193;4443.244648409778;4476.753778542212;4479.417675702138;4483.798229079699;4520.412346394947;4567.451905771329;4681.812727490998;4696.600788932842;4806.615470762401;4830.178869592108;4960.23116416956;4962.057209130254;5044.672096313728;5063.265826455217;5075.086484432837;4784.425868895755;4797.620587094371;4807.519248075304;4810.11012962603;4842.7336496491625;4732.171869922681;4973.5523802857915;4993.650444468853;4998.775055122601;5043.344365232496;5007.499250074963;5015.573676237561;5048.444671086251;5102.4897510248675;5145.948540514547;4877.634177436636;4886.877828054327;4889.339939108175;4894.486078961658;4931.48219436954;4691.460482044472;4884.023195361013;4885.340479035427;4890.584300334369;4942.555170034714;4709.222978208557;4714.434267887876;4729.8108075677965;4802.495737947465;4842.7336496493035;4947.431045429677;4949.851504454872;4953.678010929278;4966.6771659842;4980.377452818398;4839.104765618372;4841.467438581823;4842.4189097308545;4848.0788650156355;4887 09:23:10 INFO - 2015-12-13 09:23:10,840 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.4954666027247;559.4573263933984;573.8278516445065;578.3060327606871;583.7898356591626;27196;27819.86090069552;27838.721612783866;35690.2861942761;36364.272714545696;40608.39087413691;41163;41183.176336473254;41231.79384103083;41234;7772.222777722225;7936.047674279066;7951;7951.204879512032;7952.681892724284;7079.504434689574;7245.818854528627;9966.352187107816;10267.281290309682;10269.948650256738;9950.154236889874;10114.696559103239;10141.645042423517;10156.441395723232;10185.949070254639;7269.6728647211;7473.215312392175;9805.705828825146;9881.950590247076;9894.356866803706;10150.492475376202;10310.226732995055;10354.17166626668;10435.68692939213;10437.739056523647;37289;37784.43323350152;38197;38220.42669359962;38234;2967.5845381646373;3010.6838781928022;3455.2398472336045;3511.17487390463;3552.6980206682465;27468.450630987467;28134.155975320773;28237.43525129486;28536.286592835346;30903.690963090532;3290.473524236135;3326.434506133963;3380.932381352384;3394.185395505061;3458.9308213835834;214483;215904;216372;217851;218855;56986.430135698116;57474.976751626986;57519.13721294184;57521;57542.42457575454;61085.69457152686;61431.69284153551;61502;61581.69209154015;61655;12559.686007849878;12877;12881.871181288254;12905;12905.41925613331;9515.714528564155;9548.952255238679;9615.855762163574;9676;9958.900410995942;18568.328869949382;19386.80613193878;19398.8060119397;19421;19427.32004379868;7604.315611594983;7898.605069746604;7938.920610793818;7975.481593696391;8073.555954422446;810.1291112054565;835.6281454752577;861.4788053227833;890.5591732092655;981.018981018981;26407.603885941728;26732.19803405901;26765.330866728098;30982;31933.52099718506;871.6818361298207;969.970900872975;977.867987821635;996.8654231678776;1003.2225025605214;13263.403146858414;13411.530596429078;13600.65998350049;13626.523071692443;13645.795313070312;314142;320708;321112;321493;321907;42985.35521967173;44040;44237.77881110574;46244.76877615591;47547.28679069817;1219.7316590350108;1225.7609766095704;1239.3741160713962;1260.5966090850839;1260.9621711348675;26172.8691356542;26689.33276668099;27234.04680836161;30370.696293036788;31251.53122703116;44446;44991;45006.77496612496;45120.32319515144;45136.322955156356;252130;253803;254881;255028;255827;39682.15341064312;39966.600333996284;40155.1968960625;40473.39289910595;40508;41422.58577414187;42668.359974599785;42801.35797963096;43607.56392436035;43794.781026094664;36340;39032.41451378288;40488.190236194525;40724;41742;33152.83423582867;33813;33913;34288.142796430286;34350.82824585961;32706.67293327036;33288.1677958053;33383.33233335368;33500.49749253812;33542.16144596405;29508.557371639014;30804.075877723702;30970.84514577413;31217.53173702351;31241.843790780902;23608.527829443658;23916;24903.630300333654;25000.249992500256;25605.743942561083 09:23:10 INFO - 2015-12-13 09:23:10,840 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.2367425943109;338.1816005267253;338.3402365387494;339.7842370094989;341.35313580764466;12533.749325013494;12912.096153269275;15073.547793566197;15098.698026039472;16311;11884.7623047539;14031.5088971886;14218.360173792178;14228.644283892882;14758.40966361347;3905.5899130591306;4313.568643135693;4907.411110666725;5056.898862022757;5088.592912566985;3778.7732736035787;3903.6291552302487;3905.4922860028155;3906.2968665640174;4974.602031837444;3879.262940041383;5569.554435645138;5784.3058832940105;5789.710514474281;5798.2172406725185;5598.300212473441;5605.5515558755405;5612.971935140339;5627.971860140714;5771.740271687763;4884.780184891689;4887.071456423304;4917.631177661654;4939.160342741742;4951.183054795954;18651.440456786317;19247.711284330606;19478.51303717404;19650.90174549118;19775.80224197754;1869.8597605179666;1938.6413513500047;1945.5525229197222;1977.980220197794;2041.530447996954;12060.216085954386;12366.62900112998;12394.62816115518;12467.875321246762;12733.299668518228;1701.5575950252899;1724.146547459016;1732.194529543768;1737.9131043447903;1766.2846547148426;48953;49925.25112123321;51623;52418.21372679413;53820.192697109575;8920.420172688755;9259.537023148816;9572.090651388107;9580.377275477073;9640.71077867665;12157.209781364183;12166.513339466323;12172.878271217352;12184.756304873852;12187.512499500099;6233.438990490878;6304.842378940563;6364.84087897797;6380.266269378988;6607.240167380813;5840.795572154954;6144.723487443076;6164.137020817089;6234.2830574483605;6243.500519958392;4043.130726893732;4058.492688413948;4061.268971585143;4140.047789008545;4160.687948403882;1577.5582836805713;1605.6628108097198;1634.6975809475284;1642.5565097423628;1687.2491741175304;792.9405294602927;799.7840583042546;837.3050368194384;997.7755005123935;999.9900001000043;13576.524821631394;14780.852191478163;15662.843371566367;15795.894287399771;15881.841181588266;793.5794029164553;796.307212724933;807.8828569857455;818.4557269415891;842.6250318608284;8929.955350223207;9073.410228335137;9170.220531254785;9190.264778817813;9290.628374865066;506535;511959;515998;524244;525979;69378;71265.6436717813;71999.28000719925;72330;73150.26849731541;1060.6287799270194;1095.8575385200033;1106.8671759388924;1114.6990312615549;1117.3966058328574;13610.59168224955;14892.627684307545;15083.622909426913;15283.46507872219;15374.538763837103;33019.33961320808;33256.667433325354;33498.162545936546;33725;35616.82191589026;43170;44259;44688;45021.77489112534;45403.318950215114;8300.875486867822;8688.609012594323;8736.08271131522;8751.387402881737;8772.122787721177;10243.38539687621;10704.946475267574;11816.704582385166;15250.084994900342;15552.611184720472;10867.184961127788;11145.83281250798;13005.154664946747;13164.736705266032;13200.339983001004;12639.557615483414;12861.421236044212;13096.672583185496;13292.20246785196;13519.256440895846;13213.603591892259;13228.272445015617;13377.53178638743;13736.381862816397;13887.166769993428;8652.78368040804;8781.736547903573;8787.165219304155;8843.867341989746;9160.587773550073;13070.54253101175;13166.144200626928;13445.865541344461;13612.183269003892;13789.172649641054 09:23:10 INFO - 2015-12-13 09:23:10,844 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1215.30120180896;1643.1701990494798;1658.469289827255;1701.3534856754425;1716.7339062445321;6081.726322315495;6822.283660215674;7079.115110611174;7090.397316228127;7107.644617769104;6898.448124150069;7071.787846364605;7071.929280707204;7079;7088.397486213665;1992.770831354391;2025.7771645119099;2026.5035066408677;2028.3712049264775;2029.1071928351553;1879.3798046644642;1883.4820424383267;1887.4149013805695;1954.491832123644;1956.9706454403195;1994.0129635830212;1995.4013795861256;2019.6465618516702;2033.0851116997337;2041.4590133614604;1988.4034789563145;2001.4596059064045;2004.6692295771106;2013.2852837242715;2032.6138033773536;2027.4829918370722;2031.3601215617034;2033.888136152511;2079.2514694709894;2089.101686274901;7134.072570565845;7212.350888420067;7212.423006159494;7219.314165154302;7225.927740722578;4070.0638853063665;4093.385992101179;4101.405296232059;4125.154343359604;4129.112240868228;2527.140772137482;2554.859482728449;2558.692956845172;2561.897524099034;2576.742325767427;812.175641723651;840.9453385529921;855.5679381912095;861.7457849934221;866.3502373220085;9675.467849268287;9683.612655493771;9689.467079310634;9691;9869.950650246774;3674.191677830873;3719.5350581177354;3757.9436308454847;3761.3041587306434;3765.077555998798;8293.668253269921;8341.499510029418;8346.457480263885;8349;8357.331413487029;4091.284025295561;4127.277726397869;4149.439825623502;4171.249175148502;4175.582441755861;3211.341674956628;3293.1108600677685;3723.832427540767;3768.491253680718;3840.615938406137;3102.4105419970133;3193.0740085375446;3219.597550306212;3251.430999575065;3284.0968733597974;1056.3978532236706;1077.5937401690712;1078.5901357484106;1079.0935614084208;1084.4902895639036;728.0135416510658;773.7253275087376;838.2330167896307;877.1316396767155;912.1106920752213;6593.901091483632;6674.466042716571;6791.4227290679855;6801.285864984205;6811.897821532681;958.324381311174;968.1818863060703;1002.5739060899089;1028.136365453008;1030.175859312547;5195;5289.814856480005;5311.044012077863;5332;5333.973330133402;8519.872201916976;8651.697190598425;8745.606447709868;8755.868661970075;8779.29765618749;8341.749747507585;8407.873881891777;8439.662413503514;8519.190676885686;8593.8710919335;6518.413342799171;6650.434713049348;6655.800325990325;6691.899621505681;6727.058211850345;6213.720382582885;6287.497000240061;6337.112804207507;6346.968265158829;6404.039394090923;7089.61007144612;7289.2710728928805;7370.336669699753;7376.299251571092;7533.962330188314;7387.9261207387235;7452.21751716062;7460.179380268275;7561.924380756122;7563.508371955805;5962.672053037125;6041.093835924647;6048.879022419615;6049.576529642883;6054.6064505808745;6622.933770662425;6655.966720166368;6663.533552651268;6682.766103186365;6693.966530167318;6358.713857876499;6468.094466774749;6535.836604084936;6588.604683718992;6624.403803657694;5419.295491586068;5575.581831362745;5723.3418156912485;6260.937390626035;6273.215848018997;6192.845178870564;6338.683065846597;6353.364663533795;6359.046143078575;6364.949783285706;5844.883102338014;5928.792492262923;5984.251968503937;6021.217241758543;6034.185384972972;5769.826905192851;5926.703664816828;5935.198748169115;5953.553483488669;5983.222181116427 09:23:10 INFO - 2015-12-13 09:23:10,845 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.3803294065991;298.51044287368717;302.93638335949447;305.0528110217775;305.3861737906807;5348.518633323;5376.542993845518;5387.326584176978;5411.188321751739;5420.159875219348;4978.701277923327;4987.426445958716;5095.337606111209;5116.079105760961;5302.893942121155;3964.0684439156776;3968.5436174839974;3977.6420122188997;3979;3993.54074281457;3828.502294701685;3979.1643754811525;3980.7810570418615;3982.641562259396;3986.382110772835;3863.9034024149482;3922.3332033554366;4015.477987861574;4053.1691003344245;4086.4074709167153;4036.616521430459;4062.532808726975;4108.85619003335;4118.979405102985;4125.7524548527035;3536.487209354629;3553.289342131584;3554.697850682695;3560.1989552350774;3565.7682250653625;5024.171011783052;5025.994801039807;5033.924491132636;5036.194208926554;5045.117104506733;4534.934290441776;4631.842039490128;4640.721556706575;4646.9767651161865;4658.114958157973;5440.809571665012;5446.400895901447;5454.236406903036;5462.5083742462975;5472.50747432729;3917.216556688674;3936.822842972073;3957.6042395760483;3959.8020098994934;3964.108075682977;5845.41545845412;5863.560232982501;5866.618669786493;5869;5871.882562348772;3955.248502784462;4060.3909413587608;4062.918741625151;4068.572799856032;4077.898052548651;4115.5678653741525;4123.8556650517685;4124.13393187434;4127.8968025799595;4128.380742888591;4681.110588988149;4689.906201876011;4692;4698.506656801055;4699.013207226452;5579.079451890474;5580.748866301026;5580.972095139498;5589.161625756169;5594.972025139929;1370.287450525741;1425.8788003019858;1442.1563385419438;1465.9120452772868;1467.4643755029338;905.9139381758722;952.1430712358932;955.5890966884307;961.0485619237045;962;4773.451053128865;4778.5699287064335;4861.854144375674;4867.537583929521;4886.609071274361;5637.069883469182;5647.136444973149;5652.8869422611315;5728.627639203439;5764.827055188351;4749.810007599657;4749.976250118727;4751.263554149044;4876.21980483121;4887.095887260868;3060.877564897379;3083.9074827755203;3092.38152369527;3105.2702614885484;3172.381385629826;5563.638363506359;5577.749001294951;5581.5255703265675;5581.939431508001;5585.162225666182;6022.909656355158;6037.72830222641;6038.124471951543;6045.939540604626;6049.425304596057;5415.214793854869;5578.3584887738425;5598.552115830806;5600.719964001865;5601.943980560224;5905.379935106752;5909.172715819703;5915.112733090071;5920.052791553331;5921.289445266596;5758.424157584208;5761.135829625589;5763.366029736641;5763.933672270643;5768.94231057684;5422.403535611158;5581.10702287632;5592.524635405874;5595.496405323541;5596.5242954347705;3997.1605962746985;4034.616711412411;4039.8788036358956;4042.9797851010558;4049.068714195693;5903;5908.645481271137;5913.083472061838;5914.911276330772;5917.763289468373;5543.611947163821;5674.971625141848;5687.971560142339;5692.288463942007;5701.657900525982;5662.094064949588;5664.971675141598;5665.405132461197;5669.518090962314;5682.3465301489205;5535.833924982257;5538.584606154635;5540.889182216414;5545.639533430314;5549.861253468534;5695.686737229492;5707.68607726579;5708.34354049273;5708.429157084258;5713.485786279255;5396.7571459283645;5559.722013899208;5571.13647384656;5572.526335261548;5579.916301255404 09:23:10 INFO - 2015-12-13 09:23:10,846 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.2805834457267;765.3532764813732;774.7443343696581;779.5985067690141;787.8660627693291;10467.371957682544;10559.524821383036;10627;10795.08241799448;10811.027007569317;10760;10912.945435272832;10929.781404371908;10938.781224375507;10947.288426252288;605.4429924469476;619.0961196652892;780.7306479264645;808.1110778144024;810.1331575214523;787.5865170785355;788.3062904643905;793.964271607779;794.6026986506747;795.1213908630966;639.884820732268;832.5753865528594;840.3361344537808;840.3403328387217;841.0034109580137;647.5273050673012;792.3581898662102;812.9674813007473;817.4441379861692;818.8485130250923;609.8140067279478;612.6477275566567;613.2640831002815;618.5144661440793;619.201230412767;10902.236843420964;11007;11041.447927603587;11053.336799792038;11154.274972126866;9852.852207216825;9995.70012899607;10167.389956602627;10782.784344313148;11456.255343402736;9999.950000250024;10157.593696252141;10212.489375531268;10263.692089237335;10359.430231337274;3217.7699827601737;3231.94771320211;3283.4910588858525;3339.699427051577;3341.2649217172425;40219.597804021876;40568.1886362274;40624.98437539056;40660.593394065974;40689.186216275804;9086.772830679285;9107.22588579965;9197.673142355336;9262.397944133745;9333.70482407254;15332.923335383475;15568.377264909503;15591.532254032398;15596.298166582532;15631.843681563267;6202.968985155046;6225.501959843202;6269.561130720897;6271.372862713783;6324.3991820776955;3674.9081272967856;3679.7792132472136;3688.704903607705;3691.7415780895617;3802.980985095057;2595.1306312385564;2634.012245407972;2646.523625747384;2646.947061058768;2647.444036752265;478.9233722604367;484.9830255941025;485.58482497464865;496.9776360063806;497.2739799892126;553.6051181238853;581.8603535151533;596.6390333848046;596.8120042186697;596.8418369132183;7800.180980996914;8457.450265732708;8619;8715.346349023848;8832.160944710242;420.9158168366339;546.4071482441595;587.8354060862965;611.2298503885137;627.9654618995908;3383.8138902360115;3419.6238413774463;3435.4331535296897;3447.0717350094683;3491.0748651607346;46721;47215.291770623466;47298;47363.76318118387;47442.525574744504;41757.58242417537;42292.78853605712;42526.362104568456;42795.35806962898;43183.56816431858;39208.01979950467;39617;39903.60096399057;40576.391354129715;40778.79610601987;6788.253292137762;6931.1682598088555;6931.306869313028;7130.679119439534;7312.400850070417;28674.283142921595;29120;29475.852620736758;29558.113256601475;29603;34053.82973085119;34267.65732342644;37255.441168381956;37446.43830342602;37647.05882352853;8870.556472176237;8904.643814247616;9171.266298695955;9235.861462078208;9266.397684150508;10117.544710487899;10150.847737284093;10168.542415591168;10245.231607629308;10267.229957753048;9226.815463690822;9255.120763527724;9262.073792620684;9266.397684150777;9297.442153470813;9250.814983700422;9351.906480935104;9402.52987350616;9429.622815087594;9501.95478497351;9040.462312260366;9280.350375473652;9421.104995025462;9464.148226659634;9487.241020718464;7935.484193527403;8104.473209241381;8261.669533218605;8348.624311905858;8366.288865446506;8155.225253600898;8195.877061843958;8227.465214761021;8250;8350.415470916978 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,886 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: __startTimestamp1450027390834__endTimestamp 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:23:10 INFO - 2015-12-13 09:23:10,847 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:23:10 INFO - 2015-12-13 09:23:10,848 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,848 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4628.47 Median:4754.71 stddev:489.46 (10.3%) stddev-sans-first:465.29 09:23:10 INFO - 2015-12-13 09:23:10,848 DEBUG : BROWSER_OUTPUT: Values: 2634.3 2701.9 2711.4 2719.4 2736.2 4419.4 4570.7 4683.9 4719.1 4725.8 4594.2 4599.5 4606.4 4622.6 4789.5 4242.8 4268.2 4289.8 4350.5 4374.6 4277.9 4355.8 4381.6 4382.8 4436.4 4107.2 4201.9 4223.0 4359.8 4376.1 4354.2 4358.1 4370.1 4382.9 4400.5 4348.7 4365.1 4365.8 4369.1 4386.7 4398.5 4469.6 4513.4 4515.2 4577.4 5073.9 5081.1 5084.4 5085.1 5130.6 5110.3 5113.8 5114.3 5120.5 5153.3 4502.2 4521.8 4625.6 4630.5 4728.7 5156.6 5275.6 5275.8 5276.4 5321.0 5054.7 5065.3 5073.1 5073.7 5124.1 4754.7 4877.9 4882.5 4993.5 5068.2 4881.4 4885.8 4885.9 4906.8 4927.6 4854.4 4858.1 4863.7 4874.3 4911.4 4004.9 4048.1 4104.7 4111.9 4136.0 3645.3 3651.8 3682.5 3692.7 3729.3 4315.1 4324.8 4327.2 4366.6 4367.0 4843.4 4972.9 4975.7 5002.5 5036.2 4248.9 4316.5 4341.5 4379.4 4411.7 4443.2 4476.8 4479.4 4483.8 4520.4 4567.5 4681.8 4696.6 4806.6 4830.2 4960.2 4962.1 5044.7 5063.3 5075.1 4784.4 4797.6 4807.5 4810.1 4842.7 4732.2 4973.6 4993.7 4998.8 5043.3 5007.5 5015.6 5048.4 5102.5 5145.9 4877.6 4886.9 4889.3 4894.5 4931.5 4691.5 4884.0 4885.3 4890.6 4942.6 4709.2 4714.4 4729.8 4802.5 4842.7 4947.4 4949.9 4953.7 4966.7 4980.4 4839.1 4841.5 4842.4 4848.1 4887.0 09:23:10 INFO - 2015-12-13 09:23:10,848 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,848 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43337.74 Median:18903.03 stddev:69757.28 (369.0%) stddev-sans-first:69879.01 09:23:10 INFO - 2015-12-13 09:23:10,849 DEBUG : BROWSER_OUTPUT: Values: 557.5 559.5 573.8 578.3 583.8 27196.0 27819.9 27838.7 35690.3 36364.3 40608.4 41163.0 41183.2 41231.8 41234.0 7772.2 7936.0 7951.0 7951.2 7952.7 7079.5 7245.8 9966.4 10267.3 10269.9 9950.2 10114.7 10141.6 10156.4 10185.9 7269.7 7473.2 9805.7 9882.0 9894.4 10150.5 10310.2 10354.2 10435.7 10437.7 37289.0 37784.4 38197.0 38220.4 38234.0 2967.6 3010.7 3455.2 3511.2 3552.7 27468.5 28134.2 28237.4 28536.3 30903.7 3290.5 3326.4 3380.9 3394.2 3458.9 214483.0 215904.0 216372.0 217851.0 218855.0 56986.4 57475.0 57519.1 57521.0 57542.4 61085.7 61431.7 61502.0 61581.7 61655.0 12559.7 12877.0 12881.9 12905.0 12905.4 9515.7 9549.0 9615.9 9676.0 9958.9 18568.3 19386.8 19398.8 19421.0 19427.3 7604.3 7898.6 7938.9 7975.5 8073.6 810.1 835.6 861.5 890.6 981.0 26407.6 26732.2 26765.3 30982.0 31933.5 871.7 970.0 977.9 996.9 1003.2 13263.4 13411.5 13600.7 13626.5 13645.8 314142.0 320708.0 321112.0 321493.0 321907.0 42985.4 44040.0 44237.8 46244.8 47547.3 1219.7 1225.8 1239.4 1260.6 1261.0 26172.9 26689.3 27234.0 30370.7 31251.5 44446.0 44991.0 45006.8 45120.3 45136.3 252130.0 253803.0 254881.0 255028.0 255827.0 39682.2 39966.6 40155.2 40473.4 40508.0 41422.6 42668.4 42801.4 43607.6 43794.8 36340.0 39032.4 40488.2 40724.0 41742.0 33152.8 33813.0 33913.0 34288.1 34350.8 32706.7 33288.2 33383.3 33500.5 33542.2 29508.6 30804.1 30970.8 31217.5 31241.8 23608.5 23916.0 24903.6 25000.2 25605.7 09:23:10 INFO - 2015-12-13 09:23:10,849 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,849 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26975.08 Median:3829.02 stddev:84384.62 (2203.8%) stddev-sans-first:84597.63 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: Values: 336.2 338.2 338.3 339.8 341.4 12533.7 12912.1 15073.5 15098.7 16311.0 11884.8 14031.5 14218.4 14228.6 14758.4 3905.6 4313.6 4907.4 5056.9 5088.6 3778.8 3903.6 3905.5 3906.3 4974.6 3879.3 5569.6 5784.3 5789.7 5798.2 5598.3 5605.6 5613.0 5628.0 5771.7 4884.8 4887.1 4917.6 4939.2 4951.2 18651.4 19247.7 19478.5 19650.9 19775.8 1869.9 1938.6 1945.6 1978.0 2041.5 12060.2 12366.6 12394.6 12467.9 12733.3 1701.6 1724.1 1732.2 1737.9 1766.3 48953.0 49925.3 51623.0 52418.2 53820.2 8920.4 9259.5 9572.1 9580.4 9640.7 12157.2 12166.5 12172.9 12184.8 12187.5 6233.4 6304.8 6364.8 6380.3 6607.2 5840.8 6144.7 6164.1 6234.3 6243.5 4043.1 4058.5 4061.3 4140.0 4160.7 1577.6 1605.7 1634.7 1642.6 1687.2 792.9 799.8 837.3 997.8 1000.0 13576.5 14780.9 15662.8 15795.9 15881.8 793.6 796.3 807.9 818.5 842.6 8930.0 9073.4 9170.2 9190.3 9290.6 506535.0 511959.0 515998.0 524244.0 525979.0 69378.0 71265.6 71999.3 72330.0 73150.3 1060.6 1095.9 1106.9 1114.7 1117.4 13610.6 14892.6 15083.6 15283.5 15374.5 33019.3 33256.7 33498.2 33725.0 35616.8 43170.0 44259.0 44688.0 45021.8 45403.3 8300.9 8688.6 8736.1 8751.4 8772.1 10243.4 10704.9 11816.7 15250.1 15552.6 10867.2 11145.8 13005.2 13164.7 13200.3 12639.6 12861.4 13096.7 13292.2 13519.3 13213.6 13228.3 13377.5 13736.4 13887.2 8652.8 8781.7 8787.2 8843.9 9160.6 13070.5 13166.1 13445.9 13612.2 13789.2 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4889.38 Median:6068.17 stddev:2578.66 (42.5%) stddev-sans-first:2571.11 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: Values: 1215.3 1643.2 1658.5 1701.4 1716.7 6081.7 6822.3 7079.1 7090.4 7107.6 6898.4 7071.8 7071.9 7079.0 7088.4 1992.8 2025.8 2026.5 2028.4 2029.1 1879.4 1883.5 1887.4 1954.5 1957.0 1994.0 1995.4 2019.6 2033.1 2041.5 1988.4 2001.5 2004.7 2013.3 2032.6 2027.5 2031.4 2033.9 2079.3 2089.1 7134.1 7212.4 7212.4 7219.3 7225.9 4070.1 4093.4 4101.4 4125.2 4129.1 2527.1 2554.9 2558.7 2561.9 2576.7 812.2 840.9 855.6 861.7 866.4 9675.5 9683.6 9689.5 9691.0 9870.0 3674.2 3719.5 3757.9 3761.3 3765.1 8293.7 8341.5 8346.5 8349.0 8357.3 4091.3 4127.3 4149.4 4171.2 4175.6 3211.3 3293.1 3723.8 3768.5 3840.6 3102.4 3193.1 3219.6 3251.4 3284.1 1056.4 1077.6 1078.6 1079.1 1084.5 728.0 773.7 838.2 877.1 912.1 6593.9 6674.5 6791.4 6801.3 6811.9 958.3 968.2 1002.6 1028.1 1030.2 5195.0 5289.8 5311.0 5332.0 5334.0 8519.9 8651.7 8745.6 8755.9 8779.3 8341.7 8407.9 8439.7 8519.2 8593.9 6518.4 6650.4 6655.8 6691.9 6727.1 6213.7 6287.5 6337.1 6347.0 6404.0 7089.6 7289.3 7370.3 7376.3 7534.0 7387.9 7452.2 7460.2 7561.9 7563.5 5962.7 6041.1 6048.9 6049.6 6054.6 6622.9 6656.0 6663.5 6682.8 6694.0 6358.7 6468.1 6535.8 6588.6 6624.4 5419.3 5575.6 5723.3 6260.9 6273.2 6192.8 6338.7 6353.4 6359.0 6364.9 5844.9 5928.8 5984.3 6021.2 6034.2 5769.8 5926.7 5935.2 5953.6 5983.2 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4638.62 Median:5362.53 stddev:1382.94 (25.8%) stddev-sans-first:1347.83 09:23:10 INFO - 2015-12-13 09:23:10,850 DEBUG : BROWSER_OUTPUT: Values: 294.4 298.5 302.9 305.1 305.4 5348.5 5376.5 5387.3 5411.2 5420.2 4978.7 4987.4 5095.3 5116.1 5302.9 3964.1 3968.5 3977.6 3979.0 3993.5 3828.5 3979.2 3980.8 3982.6 3986.4 3863.9 3922.3 4015.5 4053.2 4086.4 4036.6 4062.5 4108.9 4119.0 4125.8 3536.5 3553.3 3554.7 3560.2 3565.8 5024.2 5026.0 5033.9 5036.2 5045.1 4534.9 4631.8 4640.7 4647.0 4658.1 5440.8 5446.4 5454.2 5462.5 5472.5 3917.2 3936.8 3957.6 3959.8 3964.1 5845.4 5863.6 5866.6 5869.0 5871.9 3955.2 4060.4 4062.9 4068.6 4077.9 4115.6 4123.9 4124.1 4127.9 4128.4 4681.1 4689.9 4692.0 4698.5 4699.0 5579.1 5580.7 5581.0 5589.2 5595.0 1370.3 1425.9 1442.2 1465.9 1467.5 905.9 952.1 955.6 961.0 962.0 4773.5 4778.6 4861.9 4867.5 4886.6 5637.1 5647.1 5652.9 5728.6 5764.8 4749.8 4750.0 4751.3 4876.2 4887.1 3060.9 3083.9 3092.4 3105.3 3172.4 5563.6 5577.7 5581.5 5581.9 5585.2 6022.9 6037.7 6038.1 6045.9 6049.4 5415.2 5578.4 5598.6 5600.7 5601.9 5905.4 5909.2 5915.1 5920.1 5921.3 5758.4 5761.1 5763.4 5763.9 5768.9 5422.4 5581.1 5592.5 5595.5 5596.5 3997.2 4034.6 4039.9 4043.0 4049.1 5903.0 5908.6 5913.1 5914.9 5917.8 5543.6 5675.0 5688.0 5692.3 5701.7 5662.1 5665.0 5665.4 5669.5 5682.3 5535.8 5538.6 5540.9 5545.6 5549.9 5695.7 5707.7 5708.3 5708.4 5713.5 5396.8 5559.7 5571.1 5572.5 5579.9 09:23:10 INFO - 2015-12-13 09:23:10,851 DEBUG : BROWSER_OUTPUT: 09:23:10 INFO - 2015-12-13 09:23:10,851 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11620.11 Median:584.85 stddev:13236.33 (2263.2%) stddev-sans-first:13248.33 09:23:10 INFO - 2015-12-13 09:23:10,852 DEBUG : BROWSER_OUTPUT: Values: 757.3 765.4 774.7 779.6 787.9 10467.4 10559.5 10627.0 10795.1 10811.0 10760.0 10912.9 10929.8 10938.8 10947.3 605.4 619.1 780.7 808.1 810.1 787.6 788.3 794.0 794.6 795.1 639.9 832.6 840.3 840.3 841.0 647.5 792.4 813.0 817.4 818.8 609.8 612.6 613.3 618.5 619.2 10902.2 11007.0 11041.4 11053.3 11154.3 9852.9 9995.7 10167.4 10782.8 11456.3 10000.0 10157.6 10212.5 10263.7 10359.4 3217.8 3231.9 3283.5 3339.7 3341.3 40219.6 40568.2 40625.0 40660.6 40689.2 9086.8 9107.2 9197.7 9262.4 9333.7 15332.9 15568.4 15591.5 15596.3 15631.8 6203.0 6225.5 6269.6 6271.4 6324.4 3674.9 3679.8 3688.7 3691.7 3803.0 2595.1 2634.0 2646.5 2646.9 2647.4 478.9 485.0 485.6 497.0 497.3 553.6 581.9 596.6 596.8 596.8 7800.2 8457.5 8619.0 8715.3 8832.2 420.9 546.4 587.8 611.2 628.0 3383.8 3419.6 3435.4 3447.1 3491.1 46721.0 47215.3 47298.0 47363.8 47442.5 41757.6 42292.8 42526.4 42795.4 43183.6 39208.0 39617.0 39903.6 40576.4 40778.8 6788.3 6931.2 6931.3 7130.7 7312.4 28674.3 29120.0 29475.9 29558.1 29603.0 34053.8 34267.7 37255.4 37446.4 37647.1 8870.6 8904.6 9171.3 9235.9 9266.4 10117.5 10150.8 10168.5 10245.2 10267.2 9226.8 9255.1 9262.1 9266.4 9297.4 9250.8 9351.9 9402.5 9429.6 9502.0 9040.5 9280.4 9421.1 9464.1 9487.2 7935.5 8104.5 8261.7 8348.6 8366.3 8155.2 8195.9 8227.5 8250.0 8350.4 09:23:10 INFO - 2015-12-13 09:23:10,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:23:10 INFO - 2015-12-13 09:23:10,852 DEBUG : BROWSER_OUTPUT: 09:23:11 INFO - 2015-12-13 09:23:11,607 INFO : Browser exited with error code: 0 09:23:11 INFO - 2015-12-13 09:23:11,622 INFO : Completed test dromaeo_css (00:18:40) 09:23:11 INFO - 2015-12-13 09:23:11,622 INFO : Starting test kraken 09:23:11 INFO - 2015-12-13 09:23:11,623 DEBUG : operating with platform_type : linux_ 09:23:11 INFO - 2015-12-13 09:23:11,623 INFO : Initialising browser for kraken test... 09:23:11 INFO - 2015-12-13 09:23:11,629 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGo3tC/profile http://localhost:40262/getInfo.html 09:23:16 INFO - 2015-12-13 09:23:16,229 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:16 INFO - 2015-12-13 09:23:16,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:16 INFO - 2015-12-13 09:23:16,229 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:16 INFO - 2015-12-13 09:23:16,230 DEBUG : BROWSER_OUTPUT: __metrics 09:23:16 INFO - 2015-12-13 09:23:16,306 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:23:16 INFO - 2015-12-13 09:23:16,374 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:17 INFO - 2015-12-13 09:23:17,199 INFO : Browser initialized. 09:23:17 INFO - 2015-12-13 09:23:17,199 INFO : Running cycle 1/1 for kraken test... 09:23:17 INFO - 2015-12-13 09:23:17,199 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGo3tC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:23:29 INFO - 2015-12-13 09:23:29,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 142323712 09:23:29 INFO - 2015-12-13 09:23:29,133 DEBUG : BROWSER_OUTPUT: 09:23:31 INFO - 2015-12-13 09:23:31,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40262/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:32 INFO - 2015-12-13 09:23:32,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 179359744 09:23:32 INFO - 2015-12-13 09:23:32,328 DEBUG : BROWSER_OUTPUT: 09:23:35 INFO - 2015-12-13 09:23:35,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40262/tests/kraken/driver.html?testName=audio-dft) 09:23:35 INFO - 2015-12-13 09:23:35,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 169213952 09:23:35 INFO - 2015-12-13 09:23:35,679 DEBUG : BROWSER_OUTPUT: 09:23:38 INFO - 2015-12-13 09:23:38,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40262/tests/kraken/driver.html?testName=audio-fft) 09:23:39 INFO - 2015-12-13 09:23:39,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 153710592 09:23:39 INFO - 2015-12-13 09:23:39,296 DEBUG : BROWSER_OUTPUT: 09:23:41 INFO - 2015-12-13 09:23:41,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40262/tests/kraken/driver.html?testName=audio-oscillator) 09:23:41 INFO - 2015-12-13 09:23:41,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 155983872 09:23:41 INFO - 2015-12-13 09:23:41,954 DEBUG : BROWSER_OUTPUT: 09:23:44 INFO - 2015-12-13 09:23:44,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:44 INFO - 2015-12-13 09:23:44,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 156831744 09:23:44 INFO - 2015-12-13 09:23:44,789 DEBUG : BROWSER_OUTPUT: 09:23:47 INFO - 2015-12-13 09:23:47,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40262/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:48 INFO - 2015-12-13 09:23:48,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 157642752 09:23:48 INFO - 2015-12-13 09:23:48,366 DEBUG : BROWSER_OUTPUT: 09:23:51 INFO - 2015-12-13 09:23:51,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40262/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:52 INFO - 2015-12-13 09:23:52,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 157626368 09:23:52 INFO - 2015-12-13 09:23:52,349 DEBUG : BROWSER_OUTPUT: 09:23:55 INFO - 2015-12-13 09:23:55,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40262/tests/kraken/driver.html?testName=json-parse-financial) 09:23:55 INFO - 2015-12-13 09:23:55,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 157298688 09:23:56 INFO - 2015-12-13 09:23:55,809 DEBUG : BROWSER_OUTPUT: 09:23:57 INFO - 2015-12-13 09:23:57,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:58 INFO - 2015-12-13 09:23:58,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 167350272 09:23:58 INFO - 2015-12-13 09:23:58,159 DEBUG : BROWSER_OUTPUT: 09:24:00 INFO - 2015-12-13 09:24:00,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:00 INFO - 2015-12-13 09:24:00,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 167477248 09:24:00 INFO - 2015-12-13 09:24:00,643 DEBUG : BROWSER_OUTPUT: 09:24:02 INFO - 2015-12-13 09:24:02,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:03 INFO - 2015-12-13 09:24:03,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 179552256 09:24:03 INFO - 2015-12-13 09:24:03,370 DEBUG : BROWSER_OUTPUT: 09:24:05 INFO - 2015-12-13 09:24:05,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:06 INFO - 2015-12-13 09:24:06,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 184639488 09:24:06 INFO - 2015-12-13 09:24:06,517 DEBUG : BROWSER_OUTPUT: 09:24:09 INFO - 2015-12-13 09:24:09,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:09 INFO - 2015-12-13 09:24:09,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 182423552 09:24:09 INFO - 2015-12-13 09:24:09,739 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40262/tests/kraken/driver.html?testName=ai-astar) 09:24:11 INFO - 2015-12-13 09:24:11,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 240701440 09:24:11 INFO - 2015-12-13 09:24:11,773 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,776 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:24:11 INFO - 2015-12-13 09:24:11,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;115;111;116;113;113;102;113;114;113 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;150;169;132;158;152;131;172;135 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |2;audio-dft;166;165;165;166;165;164;167;164;165;165 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;89;93;73;79;74;120;93;75 09:24:11 INFO - 2015-12-13 09:24:11,777 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;130;95;97;97;144;96;96;144 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;112;113;112;112;113;112;112;112;112 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;146;146;147;146 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;96;95;96;96;96 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;72;73;72;73;81;70;74 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;68;68;68;68;69;67 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;86;87;86;87;86;87;87;87 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;127;120;134;121;123;118;122;119;125 09:24:11 INFO - 2015-12-13 09:24:11,778 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;137;152;149;139;150;148;148;138 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;74;73;70;70;70;71;72;70;70 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: __startTimestamp1450027451775__endTimestamp 09:24:11 INFO - 2015-12-13 09:24:11,779 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.89 (3.4%) stddev-sans-first:4.09 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 111.0 116.0 113.0 113.0 102.0 113.0 114.0 113.0 09:24:11 INFO - 2015-12-13 09:24:11,783 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.20 Median:152.50 stddev:15.63 (10.3%) stddev-sans-first:16.48 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 150.0 169.0 132.0 158.0 152.0 131.0 172.0 135.0 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: Values: 166.0 165.0 165.0 166.0 165.0 164.0 167.0 164.0 165.0 165.0 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.20 Median:77.00 stddev:15.10 (19.6%) stddev-sans-first:15.46 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 89.0 93.0 73.0 79.0 74.0 120.0 93.0 75.0 09:24:11 INFO - 2015-12-13 09:24:11,784 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:21.22 (22.1%) stddev-sans-first:21.97 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 130.0 95.0 97.0 97.0 144.0 96.0 96.0 144.0 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:112.20 Median:112.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 113.0 112.0 112.0 113.0 112.0 112.0 112.0 112.0 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,785 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:2.91 (4.0%) stddev-sans-first:3.08 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 72.0 73.0 72.0 73.0 81.0 70.0 74.0 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,786 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 68.0 68.0 68.0 68.0 69.0 67.0 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:0.71 (0.8%) stddev-sans-first:0.50 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 86.0 87.0 86.0 87.0 86.0 87.0 87.0 87.0 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:4.95 (4.0%) stddev-sans-first:4.94 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: Values: 118.0 127.0 120.0 134.0 121.0 123.0 118.0 122.0 119.0 125.0 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:148.50 stddev:5.86 (3.9%) stddev-sans-first:5.81 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 137.0 152.0 149.0 139.0 150.0 148.0 148.0 138.0 09:24:11 INFO - 2015-12-13 09:24:11,787 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-13 09:24:11,788 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 09:24:11 INFO - 2015-12-13 09:24:11,788 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 73.0 70.0 70.0 70.0 71.0 72.0 70.0 70.0 09:24:11 INFO - 2015-12-13 09:24:11,788 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:24:11 INFO - 2015-12-13 09:24:11,788 DEBUG : BROWSER_OUTPUT: 09:24:12 INFO - 2015-12-13 09:24:12,650 INFO : Browser exited with error code: 0 09:24:12 INFO - 2015-12-13 09:24:12,695 INFO : Completed test kraken (00:01:01) 09:24:12 INFO - 2015-12-13 09:24:12,695 INFO : Starting test v8_7 09:24:12 INFO - 2015-12-13 09:24:12,696 DEBUG : operating with platform_type : linux_ 09:24:12 INFO - 2015-12-13 09:24:12,696 INFO : Initialising browser for v8_7 test... 09:24:12 INFO - 2015-12-13 09:24:12,702 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0C5bs/profile http://localhost:40262/getInfo.html 09:24:17 INFO - 2015-12-13 09:24:17,208 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:17 INFO - 2015-12-13 09:24:17,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:17 INFO - 2015-12-13 09:24:17,208 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:17 INFO - 2015-12-13 09:24:17,208 DEBUG : BROWSER_OUTPUT: __metrics 09:24:17 INFO - 2015-12-13 09:24:17,289 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:24:17 INFO - 2015-12-13 09:24:17,350 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:18 INFO - 2015-12-13 09:24:18,171 INFO : Browser initialized. 09:24:18 INFO - 2015-12-13 09:24:18,172 INFO : Running cycle 1/1 for v8_7 test... 09:24:18 INFO - 2015-12-13 09:24:18,172 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0C5bs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:30 INFO - 2015-12-13 09:24:30,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 143347712 09:24:30 INFO - 2015-12-13 09:24:30,126 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40262/tests/v8_7/run.html (next: http://localhost:40262/tests/v8_7/run.html) 09:24:51 INFO - 2015-12-13 09:24:51,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 441802752 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |0;Richards;166.36167027116952 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.21973929236498 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 09:24:51 INFO - 2015-12-13 09:24:51,849 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: |7;RegExp;28500 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: |8;Splay;618.4291898577612 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: __startTimestamp1450027491841__endTimestamp 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,850 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 166.4 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.22 Median:186.22 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 186.2 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 278.6 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 5148.7 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 2000.0 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,851 DEBUG : BROWSER_OUTPUT: Values: 786.2 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: Values: 11952.4 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28500.00 Median:28500.00 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: Values: 28500.0 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.43 Median:618.43 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: Values: 618.4 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: Values: 4850.2 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:24:51 INFO - 2015-12-13 09:24:51,852 DEBUG : BROWSER_OUTPUT: 09:24:52 INFO - 2015-12-13 09:24:52,686 INFO : Browser exited with error code: 0 09:24:52 INFO - 2015-12-13 09:24:52,704 INFO : Completed test v8_7 (00:00:40) 09:24:52 INFO - 2015-12-13 09:24:52,834 INFO : Completed test suite (00:20:21) 09:24:52 INFO - 2015-12-13 09:24:52,834 DEBUG : Working with test: dromaeo_css 09:24:52 INFO - 2015-12-13 09:24:52,834 DEBUG : Generating results file: dromaeo_css 09:24:52 INFO - 2015-12-13 09:24:52,835 DEBUG : Working with test: kraken 09:24:52 INFO - 2015-12-13 09:24:52,835 DEBUG : Generating results file: kraken 09:24:52 INFO - 2015-12-13 09:24:52,836 INFO : javascript benchmark 09:24:52 INFO - 2015-12-13 09:24:52,836 DEBUG : Working with test: v8_7 09:24:52 INFO - 2015-12-13 09:24:52,836 DEBUG : Generating results file: v8_7 09:24:52 INFO - 2015-12-13 09:24:52,836 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:24:53 INFO - 2015-12-13 09:24:53,035 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:24:53 INFO - 2015-12-13 09:24:53,035 DEBUG : process_Request line: dromaeo_css 6270.25 graph.html#tests=[[72,132,35]] 09:24:53 INFO - 2015-12-13 09:24:53,036 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:24:53 INFO - 2015-12-13 09:24:53,146 DEBUG : process_Request line: kraken 1539.80 graph.html#tests=[[232,132,35]] 09:24:53 INFO - 2015-12-13 09:24:53,146 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:24:53 INFO - 2015-12-13 09:24:53,196 DEBUG : process_Request line: v8_7 19684.48 graph.html#tests=[[230,132,35]] 09:24:53 INFO - 2015-12-13 09:24:53,197 INFO : javascript benchmark 09:24:53 INFO - 2015-12-13 09:24:53,201 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.301909993852, 2701.918942431728, 2711.4170453352526, 2719.360950176709, 2736.179146256123, 4419.359192917033, 4570.725756454607, 4683.882902927428, 4719.056188762244, 4725.810967561298, 4594.150082234789, 4599.494055653875, 4606.424196975378, 4622.630189584834, 4789.4731579526315, 4242.809073591696, 4268.231718290706, 4289.8498552550745, 4350.499692535352, 4374.584414480635, 4277.914441711164, 4355.7604331761895, 4381.627561657263, 4382.7589482578605, 4436.44544431946, 4107.199096176247, 4201.894952626179, 4222.978885105555, 4359.782010899474, 4376.102898905717, 4354.194474022316, 4358.106588149421, 4370.060437006027, 4382.948092457787, 4400.515943246241, 4348.7390756554705, 4365.083332500179, 4365.80353884076, 4369.1480161368545, 4386.736795792231, 4398.450193725752, 4469.553044695537, 4513.368128462018, 4515.209838278321, 4577.382053422779, 5073.898522029575, 5081.136206844845, 5084.389873215201, 5085.135526960388, 5130.640855140142, 5110.28456016158, 5113.769880355356, 5114.2584325273, 5120.513551212629, 5153.2785410042625, 4502.234620114556, 4521.796519156645, 4625.629949604024, 4630.536946305342, 4728.692634978785, 5156.639035267495, 5275.630705850554, 5275.762590683428, 5276.445973172762, 5321.015612111694, 5054.747262636927, 5065.290859279704, 5073.086844368049, 5073.695578265316, 5124.077666020077, 4754.7147171169845, 4877.902441951142, 4882.462929077869, 4993.525615066563, 5068.214426763858, 4881.389826271716, 4885.8045678173185, 4885.9022819544125, 4906.754662266872, 4927.556519913225, 4854.441739200037, 4858.1012512685265, 4863.708177509361, 4874.268859671078, 4911.386076740408, 4004.8998775030273, 4048.149888523443, 4104.733192342488, 4111.8972025699595, 4135.98668326262, 3645.2527231917393, 3651.817409129586, 3682.5028621135802, 3692.7230457715777, 3729.291434627412, 4315.136972605492, 4324.783760811947, 4327.221100201994, 4366.607005369532, 4367.0, 4843.418789745253, 4972.8508144755715, 4975.726335051607, 5002.52476014778, 5036.244563315458, 4248.852809741353, 4316.482022157361, 4341.522432532419, 4379.430674012358, 4411.735295882193, 4443.244648409778, 4476.753778542212, 4479.417675702138, 4483.798229079699, 4520.412346394947, 4567.451905771329, 4681.812727490998, 4696.600788932842, 4806.615470762401, 4830.178869592108, 4960.23116416956, 4962.057209130254, 5044.672096313728, 5063.265826455217, 5075.086484432837, 4784.425868895755, 4797.620587094371, 4807.519248075304, 4810.11012962603, 4842.7336496491625, 4732.171869922681, 4973.5523802857915, 4993.650444468853, 4998.775055122601, 5043.344365232496, 5007.499250074963, 5015.573676237561, 5048.444671086251, 5102.4897510248675, 5145.948540514547, 4877.634177436636, 4886.877828054327, 4889.339939108175, 4894.486078961658, 4931.48219436954, 4691.460482044472, 4884.023195361013, 4885.340479035427, 4890.584300334369, 4942.555170034714, 4709.222978208557, 4714.434267887876, 4729.8108075677965, 4802.495737947465, 4842.7336496493035, 4947.431045429677, 4949.851504454872, 4953.678010929278, 4966.6771659842, 4980.377452818398, 4839.104765618372, 4841.467438581823, 4842.4189097308545, 4848.0788650156355, 4887.0], "unit": "ms", "name": "dojo.html", "value": 4597.996016691647}, {"lowerIsBetter": false, "replicates": [557.4954666027247, 559.4573263933984, 573.8278516445065, 578.3060327606871, 583.7898356591626, 27196.0, 27819.86090069552, 27838.721612783866, 35690.2861942761, 36364.272714545696, 40608.39087413691, 41163.0, 41183.176336473254, 41231.79384103083, 41234.0, 7772.222777722225, 7936.047674279066, 7951.0, 7951.204879512032, 7952.681892724284, 7079.504434689574, 7245.818854528627, 9966.352187107816, 10267.281290309682, 10269.948650256738, 9950.154236889874, 10114.696559103239, 10141.645042423517, 10156.441395723232, 10185.949070254639, 7269.6728647211, 7473.215312392175, 9805.705828825146, 9881.950590247076, 9894.356866803706, 10150.492475376202, 10310.226732995055, 10354.17166626668, 10435.68692939213, 10437.739056523647, 37289.0, 37784.43323350152, 38197.0, 38220.42669359962, 38234.0, 2967.5845381646373, 3010.6838781928022, 3455.2398472336045, 3511.17487390463, 3552.6980206682465, 27468.450630987467, 28134.155975320773, 28237.43525129486, 28536.286592835346, 30903.690963090532, 3290.473524236135, 3326.434506133963, 3380.932381352384, 3394.185395505061, 3458.9308213835834, 214483.0, 215904.0, 216372.0, 217851.0, 218855.0, 56986.430135698116, 57474.976751626986, 57519.13721294184, 57521.0, 57542.42457575454, 61085.69457152686, 61431.69284153551, 61502.0, 61581.69209154015, 61655.0, 12559.686007849878, 12877.0, 12881.871181288254, 12905.0, 12905.41925613331, 9515.714528564155, 9548.952255238679, 9615.855762163574, 9676.0, 9958.900410995942, 18568.328869949382, 19386.80613193878, 19398.8060119397, 19421.0, 19427.32004379868, 7604.315611594983, 7898.605069746604, 7938.920610793818, 7975.481593696391, 8073.555954422446, 810.1291112054565, 835.6281454752577, 861.4788053227833, 890.5591732092655, 981.018981018981, 26407.603885941728, 26732.19803405901, 26765.330866728098, 30982.0, 31933.52099718506, 871.6818361298207, 969.970900872975, 977.867987821635, 996.8654231678776, 1003.2225025605214, 13263.403146858414, 13411.530596429078, 13600.65998350049, 13626.523071692443, 13645.795313070312, 314142.0, 320708.0, 321112.0, 321493.0, 321907.0, 42985.35521967173, 44040.0, 44237.77881110574, 46244.76877615591, 47547.28679069817, 1219.7316590350108, 1225.7609766095704, 1239.3741160713962, 1260.5966090850839, 1260.9621711348675, 26172.8691356542, 26689.33276668099, 27234.04680836161, 30370.696293036788, 31251.53122703116, 44446.0, 44991.0, 45006.77496612496, 45120.32319515144, 45136.322955156356, 252130.0, 253803.0, 254881.0, 255028.0, 255827.0, 39682.15341064312, 39966.600333996284, 40155.1968960625, 40473.39289910595, 40508.0, 41422.58577414187, 42668.359974599785, 42801.35797963096, 43607.56392436035, 43794.781026094664, 36340.0, 39032.41451378288, 40488.190236194525, 40724.0, 41742.0, 33152.83423582867, 33813.0, 33913.0, 34288.142796430286, 34350.82824585961, 32706.67293327036, 33288.1677958053, 33383.33233335368, 33500.49749253812, 33542.16144596405, 29508.557371639014, 30804.075877723702, 30970.84514577413, 31217.53173702351, 31241.843790780902, 23608.527829443658, 23916.0, 24903.630300333654, 25000.249992500256, 25605.743942561083], "unit": "ms", "name": "ext.html", "value": 17740.54667882349}, {"lowerIsBetter": false, "replicates": [336.2367425943109, 338.1816005267253, 338.3402365387494, 339.7842370094989, 341.35313580764466, 12533.749325013494, 12912.096153269275, 15073.547793566197, 15098.698026039472, 16311.0, 11884.7623047539, 14031.5088971886, 14218.360173792178, 14228.644283892882, 14758.40966361347, 3905.5899130591306, 4313.568643135693, 4907.411110666725, 5056.898862022757, 5088.592912566985, 3778.7732736035787, 3903.6291552302487, 3905.4922860028155, 3906.2968665640174, 4974.602031837444, 3879.262940041383, 5569.554435645138, 5784.3058832940105, 5789.710514474281, 5798.2172406725185, 5598.300212473441, 5605.5515558755405, 5612.971935140339, 5627.971860140714, 5771.740271687763, 4884.780184891689, 4887.071456423304, 4917.631177661654, 4939.160342741742, 4951.183054795954, 18651.440456786317, 19247.711284330606, 19478.51303717404, 19650.90174549118, 19775.80224197754, 1869.8597605179666, 1938.6413513500047, 1945.5525229197222, 1977.980220197794, 2041.530447996954, 12060.216085954386, 12366.62900112998, 12394.62816115518, 12467.875321246762, 12733.299668518228, 1701.5575950252899, 1724.146547459016, 1732.194529543768, 1737.9131043447903, 1766.2846547148426, 48953.0, 49925.25112123321, 51623.0, 52418.21372679413, 53820.192697109575, 8920.420172688755, 9259.537023148816, 9572.090651388107, 9580.377275477073, 9640.71077867665, 12157.209781364183, 12166.513339466323, 12172.878271217352, 12184.756304873852, 12187.512499500099, 6233.438990490878, 6304.842378940563, 6364.84087897797, 6380.266269378988, 6607.240167380813, 5840.795572154954, 6144.723487443076, 6164.137020817089, 6234.2830574483605, 6243.500519958392, 4043.130726893732, 4058.492688413948, 4061.268971585143, 4140.047789008545, 4160.687948403882, 1577.5582836805713, 1605.6628108097198, 1634.6975809475284, 1642.5565097423628, 1687.2491741175304, 792.9405294602927, 799.7840583042546, 837.3050368194384, 997.7755005123935, 999.9900001000043, 13576.524821631394, 14780.852191478163, 15662.843371566367, 15795.894287399771, 15881.841181588266, 793.5794029164553, 796.307212724933, 807.8828569857455, 818.4557269415891, 842.6250318608284, 8929.955350223207, 9073.410228335137, 9170.220531254785, 9190.264778817813, 9290.628374865066, 506535.0, 511959.0, 515998.0, 524244.0, 525979.0, 69378.0, 71265.6436717813, 71999.28000719925, 72330.0, 73150.26849731541, 1060.6287799270194, 1095.8575385200033, 1106.8671759388924, 1114.6990312615549, 1117.3966058328574, 13610.59168224955, 14892.627684307545, 15083.622909426913, 15283.46507872219, 15374.538763837103, 33019.33961320808, 33256.667433325354, 33498.162545936546, 33725.0, 35616.82191589026, 43170.0, 44259.0, 44688.0, 45021.77489112534, 45403.318950215114, 8300.875486867822, 8688.609012594323, 8736.08271131522, 8751.387402881737, 8772.122787721177, 10243.38539687621, 10704.946475267574, 11816.704582385166, 15250.084994900342, 15552.611184720472, 10867.184961127788, 11145.83281250798, 13005.154664946747, 13164.736705266032, 13200.339983001004, 12639.557615483414, 12861.421236044212, 13096.672583185496, 13292.20246785196, 13519.256440895846, 13213.603591892259, 13228.272445015617, 13377.53178638743, 13736.381862816397, 13887.166769993428, 8652.78368040804, 8781.736547903573, 8787.165219304155, 8843.867341989746, 9160.587773550073, 13070.54253101175, 13166.144200626928, 13445.865541344461, 13612.183269003892, 13789.172649641054], "unit": "ms", "name": "jquery.html", "value": 8142.067110001792}, {"lowerIsBetter": false, "replicates": [1215.30120180896, 1643.1701990494798, 1658.469289827255, 1701.3534856754425, 1716.7339062445321, 6081.726322315495, 6822.283660215674, 7079.115110611174, 7090.397316228127, 7107.644617769104, 6898.448124150069, 7071.787846364605, 7071.929280707204, 7079.0, 7088.397486213665, 1992.770831354391, 2025.7771645119099, 2026.5035066408677, 2028.3712049264775, 2029.1071928351553, 1879.3798046644642, 1883.4820424383267, 1887.4149013805695, 1954.491832123644, 1956.9706454403195, 1994.0129635830212, 1995.4013795861256, 2019.6465618516702, 2033.0851116997337, 2041.4590133614604, 1988.4034789563145, 2001.4596059064045, 2004.6692295771106, 2013.2852837242715, 2032.6138033773536, 2027.4829918370722, 2031.3601215617034, 2033.888136152511, 2079.2514694709894, 2089.101686274901, 7134.072570565845, 7212.350888420067, 7212.423006159494, 7219.314165154302, 7225.927740722578, 4070.0638853063665, 4093.385992101179, 4101.405296232059, 4125.154343359604, 4129.112240868228, 2527.140772137482, 2554.859482728449, 2558.692956845172, 2561.897524099034, 2576.742325767427, 812.175641723651, 840.9453385529921, 855.5679381912095, 861.7457849934221, 866.3502373220085, 9675.467849268287, 9683.612655493771, 9689.467079310634, 9691.0, 9869.950650246774, 3674.191677830873, 3719.5350581177354, 3757.9436308454847, 3761.3041587306434, 3765.077555998798, 8293.668253269921, 8341.499510029418, 8346.457480263885, 8349.0, 8357.331413487029, 4091.284025295561, 4127.277726397869, 4149.439825623502, 4171.249175148502, 4175.582441755861, 3211.341674956628, 3293.1108600677685, 3723.832427540767, 3768.491253680718, 3840.615938406137, 3102.4105419970133, 3193.0740085375446, 3219.597550306212, 3251.430999575065, 3284.0968733597974, 1056.3978532236706, 1077.5937401690712, 1078.5901357484106, 1079.0935614084208, 1084.4902895639036, 728.0135416510658, 773.7253275087376, 838.2330167896307, 877.1316396767155, 912.1106920752213, 6593.901091483632, 6674.466042716571, 6791.4227290679855, 6801.285864984205, 6811.897821532681, 958.324381311174, 968.1818863060703, 1002.5739060899089, 1028.136365453008, 1030.175859312547, 5195.0, 5289.814856480005, 5311.044012077863, 5332.0, 5333.973330133402, 8519.872201916976, 8651.697190598425, 8745.606447709868, 8755.868661970075, 8779.29765618749, 8341.749747507585, 8407.873881891777, 8439.662413503514, 8519.190676885686, 8593.8710919335, 6518.413342799171, 6650.434713049348, 6655.800325990325, 6691.899621505681, 6727.058211850345, 6213.720382582885, 6287.497000240061, 6337.112804207507, 6346.968265158829, 6404.039394090923, 7089.61007144612, 7289.2710728928805, 7370.336669699753, 7376.299251571092, 7533.962330188314, 7387.9261207387235, 7452.21751716062, 7460.179380268275, 7561.924380756122, 7563.508371955805, 5962.672053037125, 6041.093835924647, 6048.879022419615, 6049.576529642883, 6054.6064505808745, 6622.933770662425, 6655.966720166368, 6663.533552651268, 6682.766103186365, 6693.966530167318, 6358.713857876499, 6468.094466774749, 6535.836604084936, 6588.604683718992, 6624.403803657694, 5419.295491586068, 5575.581831362745, 5723.3418156912485, 6260.937390626035, 6273.215848018997, 6192.845178870564, 6338.683065846597, 6353.364663533795, 6359.046143078575, 6364.949783285706, 5844.883102338014, 5928.792492262923, 5984.251968503937, 6021.217241758543, 6034.185384972972, 5769.826905192851, 5926.703664816828, 5935.198748169115, 5953.553483488669, 5983.222181116427], "unit": "ms", "name": "mootools.html", "value": 3985.2624158848566}, {"lowerIsBetter": false, "replicates": [294.3803294065991, 298.51044287368717, 302.93638335949447, 305.0528110217775, 305.3861737906807, 5348.518633323, 5376.542993845518, 5387.326584176978, 5411.188321751739, 5420.159875219348, 4978.701277923327, 4987.426445958716, 5095.337606111209, 5116.079105760961, 5302.893942121155, 3964.0684439156776, 3968.5436174839974, 3977.6420122188997, 3979.0, 3993.54074281457, 3828.502294701685, 3979.1643754811525, 3980.7810570418615, 3982.641562259396, 3986.382110772835, 3863.9034024149482, 3922.3332033554366, 4015.477987861574, 4053.1691003344245, 4086.4074709167153, 4036.616521430459, 4062.532808726975, 4108.85619003335, 4118.979405102985, 4125.7524548527035, 3536.487209354629, 3553.289342131584, 3554.697850682695, 3560.1989552350774, 3565.7682250653625, 5024.171011783052, 5025.994801039807, 5033.924491132636, 5036.194208926554, 5045.117104506733, 4534.934290441776, 4631.842039490128, 4640.721556706575, 4646.9767651161865, 4658.114958157973, 5440.809571665012, 5446.400895901447, 5454.236406903036, 5462.5083742462975, 5472.50747432729, 3917.216556688674, 3936.822842972073, 3957.6042395760483, 3959.8020098994934, 3964.108075682977, 5845.41545845412, 5863.560232982501, 5866.618669786493, 5869.0, 5871.882562348772, 3955.248502784462, 4060.3909413587608, 4062.918741625151, 4068.572799856032, 4077.898052548651, 4115.5678653741525, 4123.8556650517685, 4124.13393187434, 4127.8968025799595, 4128.380742888591, 4681.110588988149, 4689.906201876011, 4692.0, 4698.506656801055, 4699.013207226452, 5579.079451890474, 5580.748866301026, 5580.972095139498, 5589.161625756169, 5594.972025139929, 1370.287450525741, 1425.8788003019858, 1442.1563385419438, 1465.9120452772868, 1467.4643755029338, 905.9139381758722, 952.1430712358932, 955.5890966884307, 961.0485619237045, 962.0, 4773.451053128865, 4778.5699287064335, 4861.854144375674, 4867.537583929521, 4886.609071274361, 5637.069883469182, 5647.136444973149, 5652.8869422611315, 5728.627639203439, 5764.827055188351, 4749.810007599657, 4749.976250118727, 4751.263554149044, 4876.21980483121, 4887.095887260868, 3060.877564897379, 3083.9074827755203, 3092.38152369527, 3105.2702614885484, 3172.381385629826, 5563.638363506359, 5577.749001294951, 5581.5255703265675, 5581.939431508001, 5585.162225666182, 6022.909656355158, 6037.72830222641, 6038.124471951543, 6045.939540604626, 6049.425304596057, 5415.214793854869, 5578.3584887738425, 5598.552115830806, 5600.719964001865, 5601.943980560224, 5905.379935106752, 5909.172715819703, 5915.112733090071, 5920.052791553331, 5921.289445266596, 5758.424157584208, 5761.135829625589, 5763.366029736641, 5763.933672270643, 5768.94231057684, 5422.403535611158, 5581.10702287632, 5592.524635405874, 5595.496405323541, 5596.5242954347705, 3997.1605962746985, 4034.616711412411, 4039.8788036358956, 4042.9797851010558, 4049.068714195693, 5903.0, 5908.645481271137, 5913.083472061838, 5914.911276330772, 5917.763289468373, 5543.611947163821, 5674.971625141848, 5687.971560142339, 5692.288463942007, 5701.657900525982, 5662.094064949588, 5664.971675141598, 5665.405132461197, 5669.518090962314, 5682.3465301489205, 5535.833924982257, 5538.584606154635, 5540.889182216414, 5545.639533430314, 5549.861253468534, 5695.686737229492, 5707.68607726579, 5708.34354049273, 5708.429157084258, 5713.485786279255, 5396.7571459283645, 5559.722013899208, 5571.13647384656, 5572.526335261548, 5579.916301255404], "unit": "ms", "name": "prototype.html", "value": 4192.627136983846}, {"lowerIsBetter": false, "replicates": [757.2805834457267, 765.3532764813732, 774.7443343696581, 779.5985067690141, 787.8660627693291, 10467.371957682544, 10559.524821383036, 10627.0, 10795.08241799448, 10811.027007569317, 10760.0, 10912.945435272832, 10929.781404371908, 10938.781224375507, 10947.288426252288, 605.4429924469476, 619.0961196652892, 780.7306479264645, 808.1110778144024, 810.1331575214523, 787.5865170785355, 788.3062904643905, 793.964271607779, 794.6026986506747, 795.1213908630966, 639.884820732268, 832.5753865528594, 840.3361344537808, 840.3403328387217, 841.0034109580137, 647.5273050673012, 792.3581898662102, 812.9674813007473, 817.4441379861692, 818.8485130250923, 609.8140067279478, 612.6477275566567, 613.2640831002815, 618.5144661440793, 619.201230412767, 10902.236843420964, 11007.0, 11041.447927603587, 11053.336799792038, 11154.274972126866, 9852.852207216825, 9995.70012899607, 10167.389956602627, 10782.784344313148, 11456.255343402736, 9999.950000250024, 10157.593696252141, 10212.489375531268, 10263.692089237335, 10359.430231337274, 3217.7699827601737, 3231.94771320211, 3283.4910588858525, 3339.699427051577, 3341.2649217172425, 40219.597804021876, 40568.1886362274, 40624.98437539056, 40660.593394065974, 40689.186216275804, 9086.772830679285, 9107.22588579965, 9197.673142355336, 9262.397944133745, 9333.70482407254, 15332.923335383475, 15568.377264909503, 15591.532254032398, 15596.298166582532, 15631.843681563267, 6202.968985155046, 6225.501959843202, 6269.561130720897, 6271.372862713783, 6324.3991820776955, 3674.9081272967856, 3679.7792132472136, 3688.704903607705, 3691.7415780895617, 3802.980985095057, 2595.1306312385564, 2634.012245407972, 2646.523625747384, 2646.947061058768, 2647.444036752265, 478.9233722604367, 484.9830255941025, 485.58482497464865, 496.9776360063806, 497.2739799892126, 553.6051181238853, 581.8603535151533, 596.6390333848046, 596.8120042186697, 596.8418369132183, 7800.180980996914, 8457.450265732708, 8619.0, 8715.346349023848, 8832.160944710242, 420.9158168366339, 546.4071482441595, 587.8354060862965, 611.2298503885137, 627.9654618995908, 3383.8138902360115, 3419.6238413774463, 3435.4331535296897, 3447.0717350094683, 3491.0748651607346, 46721.0, 47215.291770623466, 47298.0, 47363.76318118387, 47442.525574744504, 41757.58242417537, 42292.78853605712, 42526.362104568456, 42795.35806962898, 43183.56816431858, 39208.01979950467, 39617.0, 39903.60096399057, 40576.391354129715, 40778.79610601987, 6788.253292137762, 6931.1682598088555, 6931.306869313028, 7130.679119439534, 7312.400850070417, 28674.283142921595, 29120.0, 29475.852620736758, 29558.113256601475, 29603.0, 34053.82973085119, 34267.65732342644, 37255.441168381956, 37446.43830342602, 37647.05882352853, 8870.556472176237, 8904.643814247616, 9171.266298695955, 9235.861462078208, 9266.397684150508, 10117.544710487899, 10150.847737284093, 10168.542415591168, 10245.231607629308, 10267.229957753048, 9226.815463690822, 9255.120763527724, 9262.073792620684, 9266.397684150777, 9297.442153470813, 9250.814983700422, 9351.906480935104, 9402.52987350616, 9429.622815087594, 9501.95478497351, 9040.462312260366, 9280.350375473652, 9421.104995025462, 9464.148226659634, 9487.241020718464, 7935.484193527403, 8104.473209241381, 8261.669533218605, 8348.624311905858, 8366.288865446506, 8155.225253600898, 8195.877061843958, 8227.465214761021, 8250.0, 8350.415470916978], "unit": "ms", "name": "yui.html", "value": 5475.795711731638}], "name": "dromaeo_css", "value": 6270.250197428566}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 115.0, 111.0, 116.0, 113.0, 113.0, 102.0, 113.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 150.0, 169.0, 132.0, 158.0, 152.0, 131.0, 172.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [166.0, 165.0, 165.0, 166.0, 165.0, 164.0, 167.0, 164.0, 165.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 89.0, 93.0, 73.0, 79.0, 74.0, 120.0, 93.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 130.0, 95.0, 97.0, 97.0, 144.0, 96.0, 96.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 112.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 81.0, 70.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [118.0, 127.0, 120.0, 134.0, 121.0, 123.0, 118.0, 122.0, 119.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 137.0, 152.0, 149.0, 139.0, 150.0, 148.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 73.0, 70.0, 70.0, 70.0, 71.0, 72.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1539.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [186.21973929236498], "unit": "score", "name": "DeltaBlue", "value": 355.0536599999999}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [28500.0], "unit": "score", "name": "RegExp", "value": 31.964385964912278}, {"lowerIsBetter": false, "replicates": [618.4291898577612], "unit": "score", "name": "Splay", "value": 131.77094700000006}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19684.48220516885}]} 09:24:53 INFO - RETURN: dromaeo_css: 6270.25 09:24:53 INFO - RETURN: kraken: 1539.80 09:24:53 INFO - RETURN: v8_7: 19684.48 09:24:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19684.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1539.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6270.25"}}} 09:24:53 INFO - Return code: 0 09:24:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:24:53 INFO - # TBPL SUCCESS # 09:24:53 INFO - Running post-action listener: _resource_record_post_action 09:24:53 INFO - Running post-run listener: _resource_record_post_run 09:24:54 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 10493952; Write bytes: 414859264; Read time: 3328; Write time: 330164 09:24:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13766656; Read time: 0; Write time: 17320 09:24:54 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 8732672; Write bytes: 401092608; Read time: 3284; Write time: 312844 09:24:54 INFO - Running post-run listener: _upload_blobber_files 09:24:54 INFO - Blob upload gear active. 09:24:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:24:54 INFO - Copying logs to upload dir... 09:24:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.557701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-13 09:24:54.340721) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 09:24:54.344725) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010018 build_url: 'https://queue.taskcluster.net/v1/task/umNv1V8cTaKEjup-CbU-oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 09:24:54.399060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:24:54.399609) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450012388.751191-882352559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 09:24:54.451791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 09:24:54.452245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 09:24:54.452836) ========= ========= Total master_lag: 0.23 =========