builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1449191184.24 results: success (0) buildid: 20151203160652 builduid: 8857c2b23a644313a76dfe27e5f43ed1 revision: 43076a707aeb17df93712d073f8066665c09ee3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.242803) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.243260) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.243646) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006331 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.270764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.271278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.325072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.325375) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.402654) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.402958) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.403379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.403714) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 17:06:24-- 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% 226M=0s 2015-12-03 17:06:24 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.589025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.589356) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017292 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.646560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:24.646904) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43076a707aeb17df93712d073f8066665c09ee3d --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 43076a707aeb17df93712d073f8066665c09ee3d --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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 17:06:24,787 truncating revision to first 12 chars 2015-12-03 17:06:24,787 Setting DEBUG logging. 2015-12-03 17:06:24,787 attempt 1/10 2015-12-03 17:06:24,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43076a707aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 17:06:25,031 unpacking tar archive at: fx-team-43076a707aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544183 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:25.204035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:25.204357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:25.254337) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:25.254661) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:06:25.255117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-03 17:06:25.255459) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:25 INFO - MultiFileLogger online at 20151203 17:06:25 in /builds/slave/test 17:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 17:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:25 INFO - {'append_to_log': False, 17:06:25 INFO - 'base_work_dir': '/builds/slave/test', 17:06:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:25 INFO - 'branch': 'Fx-Team-Non-PGO', 17:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:25 INFO - 'config_files': ('talos/linux_config.py',), 17:06:25 INFO - 'default_actions': ('clobber', 17:06:25 INFO - 'read-buildbot-config', 17:06:25 INFO - 'download-and-extract', 17:06:25 INFO - 'populate-webroot', 17:06:25 INFO - 'create-virtualenv', 17:06:25 INFO - 'install', 17:06:25 INFO - 'run-tests'), 17:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:25 INFO - 'download_minidump_stackwalk': True, 17:06:25 INFO - 'download_symbols': 'ondemand', 17:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:25 INFO - 'installer_path': 'installer.exe', 17:06:25 INFO - 'log_level': 'info', 17:06:25 INFO - 'log_name': 'talos', 17:06:25 INFO - 'log_to_console': True, 17:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:25 INFO - 'opt_config_files': (), 17:06:25 INFO - 'pip_index': False, 17:06:25 INFO - 'sps_profile': False, 17:06:25 INFO - 'sps_profile_interval': 0, 17:06:25 INFO - 'suite': 'dromaeojs-e10s', 17:06:25 INFO - 'system_bits': '64', 17:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:25 INFO - 'title': 'talos-linux64-ix-020', 17:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:25 INFO - 'use_talos_json': True, 17:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:25 INFO - 'work_dir': 'build'} 17:06:25 INFO - ##### 17:06:25 INFO - ##### Running clobber step. 17:06:25 INFO - ##### 17:06:25 INFO - Running pre-action listener: _resource_record_pre_action 17:06:25 INFO - Running main action method: clobber 17:06:25 INFO - rmtree: /builds/slave/test/build 17:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:26 INFO - Running post-action listener: _resource_record_post_action 17:06:26 INFO - ##### 17:06:26 INFO - ##### Running read-buildbot-config step. 17:06:26 INFO - ##### 17:06:26 INFO - Running pre-action listener: _resource_record_pre_action 17:06:26 INFO - Running main action method: read_buildbot_config 17:06:26 INFO - Using buildbot properties: 17:06:26 INFO - { 17:06:26 INFO - "properties": { 17:06:26 INFO - "buildnumber": 548, 17:06:26 INFO - "product": "firefox", 17:06:26 INFO - "script_repo_revision": "production", 17:06:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:06:26 INFO - "repository": "", 17:06:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:06:26 INFO - "buildid": "20151203160652", 17:06:26 INFO - "slavename": "talos-linux64-ix-020", 17:06:26 INFO - "pgo_build": "False", 17:06:26 INFO - "basedir": "/builds/slave/test", 17:06:26 INFO - "project": "", 17:06:26 INFO - "platform": "ubuntu64_hw", 17:06:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:26 INFO - "slavebuilddir": "test", 17:06:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:06:26 INFO - "branch": "fx-team", 17:06:26 INFO - "repo_path": "integration/fx-team", 17:06:26 INFO - "stage_platform": "linux64", 17:06:26 INFO - "builduid": "8857c2b23a644313a76dfe27e5f43ed1", 17:06:26 INFO - "revision": "43076a707aeb17df93712d073f8066665c09ee3d" 17:06:26 INFO - }, 17:06:26 INFO - "sourcestamp": { 17:06:26 INFO - "repository": "", 17:06:26 INFO - "hasPatch": false, 17:06:26 INFO - "project": "", 17:06:26 INFO - "branch": "fx-team-linux64-talos", 17:06:26 INFO - "changes": [ 17:06:26 INFO - { 17:06:26 INFO - "category": null, 17:06:26 INFO - "files": [ 17:06:26 INFO - { 17:06:26 INFO - "url": null, 17:06:26 INFO - "name": "https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:06:26 INFO - } 17:06:26 INFO - ], 17:06:26 INFO - "repository": "", 17:06:26 INFO - "rev": "43076a707aeb17df93712d073f8066665c09ee3d", 17:06:26 INFO - "who": "dtownsend@mozilla.com", 17:06:26 INFO - "when": 1449191134, 17:06:26 INFO - "number": 6741824, 17:06:26 INFO - "comments": "Bug 1229519: Fix toolkit/components/satchel to pass eslint checks. r=dolske", 17:06:26 INFO - "project": "", 17:06:26 INFO - "at": "Thu 03 Dec 2015 17:05:34", 17:06:26 INFO - "branch": "fx-team-linux64-talos", 17:06:26 INFO - "revlink": "", 17:06:26 INFO - "properties": [ 17:06:26 INFO - [ 17:06:26 INFO - "buildid", 17:06:26 INFO - "20151203160652", 17:06:26 INFO - "Change" 17:06:26 INFO - ], 17:06:26 INFO - [ 17:06:26 INFO - "builduid", 17:06:26 INFO - "8857c2b23a644313a76dfe27e5f43ed1", 17:06:26 INFO - "Change" 17:06:26 INFO - ], 17:06:26 INFO - [ 17:06:26 INFO - "pgo_build", 17:06:26 INFO - "False", 17:06:26 INFO - "Change" 17:06:26 INFO - ] 17:06:26 INFO - ], 17:06:26 INFO - "revision": "43076a707aeb17df93712d073f8066665c09ee3d" 17:06:26 INFO - } 17:06:26 INFO - ], 17:06:26 INFO - "revision": "43076a707aeb17df93712d073f8066665c09ee3d" 17:06:26 INFO - } 17:06:26 INFO - } 17:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:06:26 INFO - Running post-action listener: _resource_record_post_action 17:06:26 INFO - ##### 17:06:26 INFO - ##### Running download-and-extract step. 17:06:26 INFO - ##### 17:06:26 INFO - Running pre-action listener: _resource_record_pre_action 17:06:26 INFO - Running main action method: download_and_extract 17:06:26 INFO - mkdir: /builds/slave/test/build/tests 17:06:26 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')]} 17:06:26 INFO - https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:06:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/test_packages.json 17:06:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/test_packages.json 17:06:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:06:30 INFO - Downloaded 1302 bytes. 17:06:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:06:30 INFO - Using the following test package requirements: 17:06:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'jsshell-linux-x86_64.zip'], 17:06:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:30 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')]} 17:06:30 INFO - https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:32 INFO - Downloaded 21788775 bytes. 17:06:32 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 17:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:32 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 17:06:33 INFO - Return code: 0 17:06:33 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 17:06:33 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')]} 17:06:33 INFO - https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:35 INFO - Downloaded 21788775 bytes. 17:06:35 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 17:06:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:06:35 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 17:06:36 INFO - Return code: 0 17:06: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')]} 17:06:36 INFO - https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:38 INFO - Downloaded 11132001 bytes. 17:06:38 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 17:06:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:38 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 17:06:38 INFO - Return code: 0 17:06:38 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')]} 17:06:38 INFO - https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1ERS-2XRQw2UOeM80Is-xg/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 17:06:39 INFO - Downloaded 57696284 bytes. 17:06:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:06:39 INFO - mkdir: /builds/slave/test/properties 17:06:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:39 INFO - Contents: 17:06:39 INFO - build_url:https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:06:39 INFO - Running post-action listener: _resource_record_post_action 17:06:39 INFO - Running post-action listener: set_extra_try_arguments 17:06:39 INFO - ##### 17:06:39 INFO - ##### Running populate-webroot step. 17:06:39 INFO - ##### 17:06:39 INFO - Running pre-action listener: _resource_record_pre_action 17:06:39 INFO - Running main action method: populate_webroot 17:06:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:06:39 INFO - '../fennec_ids.txt'], 17:06:39 INFO - 'tests': ['tcheck2']}, 17:06:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:39 INFO - '--tppagecycles', 17:06:39 INFO - '7'], 17:06:39 INFO - 'tests': ['tsvgm']}}, 17:06:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:06:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'tests': ['damp', 'tps']}, 17:06:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['damp', 'tps']}, 17:06:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:06:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:39 INFO - 'other': {'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'other_l64': {'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'other_nol64': {'tests': ['a11yr', 17:06:39 INFO - 'ts_paint', 17:06:39 INFO - 'tpaint', 17:06:39 INFO - 'sessionrestore', 17:06:39 INFO - 'sessionrestore_no_auto_restore']}, 17:06:39 INFO - 'svgr': {'tests': ['tsvgx', 17:06:39 INFO - 'tsvgr_opacity', 17:06:39 INFO - 'tart', 17:06:39 INFO - 'tscrollx', 17:06:39 INFO - 'cart']}, 17:06:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['tsvgx', 17:06:39 INFO - 'tsvgr_opacity', 17:06:39 INFO - 'tart', 17:06:39 INFO - 'tscrollx', 17:06:39 INFO - 'cart']}, 17:06:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'tests': ['tp5o']}, 17:06:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'talos_options': ['--e10s'], 17:06:39 INFO - 'tests': ['tp5o']}, 17:06:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'talos_options': ['--xperf_path', 17:06:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:39 INFO - 'tests': ['tp5n']}, 17:06:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:39 INFO - 'talos_options': ['--e10s', 17:06:39 INFO - '--xperf_path', 17:06:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:39 INFO - 'tests': ['tp5n']}}, 17:06:39 INFO - 'talos.zip': {'path': '', 17:06:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:39 INFO - Running post-action listener: _resource_record_post_action 17:06:39 INFO - ##### 17:06:39 INFO - ##### Running create-virtualenv step. 17:06:39 INFO - ##### 17:06:39 INFO - Running pre-action listener: _resource_record_pre_action 17:06:39 INFO - Running main action method: create_virtualenv 17:06:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:39 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 17:06:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:40 INFO - Using real prefix '/usr' 17:06:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:42 INFO - Installing pip.................done. 17:06:42 INFO - Return code: 0 17:06:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:42 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')]} 17:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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')]} 17:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:42 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 17:06:42 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 17:06:42 INFO - Using env: {'DISPLAY': ':0', 17:06:42 INFO - 'HOME': '/home/cltbld', 17:06:42 INFO - 'LANG': 'en_US.UTF-8', 17:06:42 INFO - 'LANGUAGE': 'en_US:en', 17:06:42 INFO - 'LOGNAME': 'cltbld', 17:06:42 INFO - 'MAIL': '/var/mail/cltbld', 17:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:42 INFO - 'MOZ_NO_REMOTE': '1', 17:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:42 INFO - 'NO_EM_RESTART': '1', 17:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:42 INFO - 'PWD': '/builds/slave/test', 17:06:42 INFO - 'SHELL': '/bin/bash', 17:06:42 INFO - 'SHLVL': '1', 17:06:42 INFO - 'TERM': 'linux', 17:06:42 INFO - 'TMOUT': '86400', 17:06:42 INFO - 'USER': 'cltbld', 17:06:42 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:42 INFO - '_': '/tools/buildbot/bin/python'} 17:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:42 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 17:06:42 INFO - Cleaning up... 17:06:42 INFO - Return code: 0 17:06:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06:42 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')]} 17:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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')]} 17:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:42 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 17:06:42 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 17:06:42 INFO - Using env: {'DISPLAY': ':0', 17:06:42 INFO - 'HOME': '/home/cltbld', 17:06:42 INFO - 'LANG': 'en_US.UTF-8', 17:06:42 INFO - 'LANGUAGE': 'en_US:en', 17:06:42 INFO - 'LOGNAME': 'cltbld', 17:06:42 INFO - 'MAIL': '/var/mail/cltbld', 17:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:42 INFO - 'MOZ_NO_REMOTE': '1', 17:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:42 INFO - 'NO_EM_RESTART': '1', 17:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:42 INFO - 'PWD': '/builds/slave/test', 17:06:42 INFO - 'SHELL': '/bin/bash', 17:06:42 INFO - 'SHLVL': '1', 17:06:42 INFO - 'TERM': 'linux', 17:06:42 INFO - 'TMOUT': '86400', 17:06:42 INFO - 'USER': 'cltbld', 17:06:42 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:42 INFO - '_': '/tools/buildbot/bin/python'} 17:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:43 INFO - Downloading/unpacking psutil>=0.7.1 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:44 INFO - Installing collected packages: psutil 17:06:44 INFO - Running setup.py install for psutil 17:06:44 INFO - building 'psutil._psutil_linux' extension 17:06:44 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 17:06:45 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 17:06:45 INFO - building 'psutil._psutil_posix' extension 17:06:45 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 17:06:45 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 17:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:45 INFO - Successfully installed psutil 17:06:45 INFO - Cleaning up... 17:06:45 INFO - Return code: 0 17:06:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:45 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')]} 17:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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')]} 17:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:45 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 17:06:45 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 17:06:45 INFO - Using env: {'DISPLAY': ':0', 17:06:45 INFO - 'HOME': '/home/cltbld', 17:06:45 INFO - 'LANG': 'en_US.UTF-8', 17:06:45 INFO - 'LANGUAGE': 'en_US:en', 17:06:45 INFO - 'LOGNAME': 'cltbld', 17:06:45 INFO - 'MAIL': '/var/mail/cltbld', 17:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:45 INFO - 'MOZ_NO_REMOTE': '1', 17:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:45 INFO - 'NO_EM_RESTART': '1', 17:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:45 INFO - 'PWD': '/builds/slave/test', 17:06:45 INFO - 'SHELL': '/bin/bash', 17:06:45 INFO - 'SHLVL': '1', 17:06:45 INFO - 'TERM': 'linux', 17:06:45 INFO - 'TMOUT': '86400', 17:06:45 INFO - 'USER': 'cltbld', 17:06:45 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:45 INFO - '_': '/tools/buildbot/bin/python'} 17:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:45 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 17:06:45 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 17:06:45 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 17:06:45 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 17:06:45 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 17:06:45 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 17:06:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:47 INFO - Installing collected packages: mozsystemmonitor 17:06:47 INFO - Running setup.py install for mozsystemmonitor 17:06:47 INFO - Successfully installed mozsystemmonitor 17:06:47 INFO - Cleaning up... 17:06:47 INFO - Return code: 0 17:06:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:47 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 17:06:47 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 17:06:47 INFO - Using env: {'DISPLAY': ':0', 17:06:47 INFO - 'HOME': '/home/cltbld', 17:06:47 INFO - 'LANG': 'en_US.UTF-8', 17:06:47 INFO - 'LANGUAGE': 'en_US:en', 17:06:47 INFO - 'LOGNAME': 'cltbld', 17:06:47 INFO - 'MAIL': '/var/mail/cltbld', 17:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:47 INFO - 'MOZ_NO_REMOTE': '1', 17:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:47 INFO - 'NO_EM_RESTART': '1', 17:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:47 INFO - 'PWD': '/builds/slave/test', 17:06:47 INFO - 'SHELL': '/bin/bash', 17:06:47 INFO - 'SHLVL': '1', 17:06:47 INFO - 'TERM': 'linux', 17:06:47 INFO - 'TMOUT': '86400', 17:06:47 INFO - 'USER': 'cltbld', 17:06:47 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:47 INFO - '_': '/tools/buildbot/bin/python'} 17:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:47 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 17:06:47 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 17:06:47 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 17:06:47 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 17:06:47 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 17:06:47 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 17:06:49 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:50 INFO - Downloading docopt-0.6.1.tar.gz 17:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:50 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:50 INFO - Running setup.py install for blobuploader 17:06:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:50 INFO - Running setup.py install for requests 17:06:50 INFO - Running setup.py install for docopt 17:06:50 INFO - Successfully installed blobuploader requests docopt 17:06:50 INFO - Cleaning up... 17:06:50 INFO - Return code: 0 17:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:50 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')]} 17:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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')]} 17:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:50 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 17:06:50 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 17:06:50 INFO - Using env: {'DISPLAY': ':0', 17:06:50 INFO - 'HOME': '/home/cltbld', 17:06:50 INFO - 'LANG': 'en_US.UTF-8', 17:06:50 INFO - 'LANGUAGE': 'en_US:en', 17:06:50 INFO - 'LOGNAME': 'cltbld', 17:06:50 INFO - 'MAIL': '/var/mail/cltbld', 17:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:50 INFO - 'MOZ_NO_REMOTE': '1', 17:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:50 INFO - 'NO_EM_RESTART': '1', 17:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:50 INFO - 'PWD': '/builds/slave/test', 17:06:50 INFO - 'SHELL': '/bin/bash', 17:06:50 INFO - 'SHLVL': '1', 17:06:50 INFO - 'TERM': 'linux', 17:06:50 INFO - 'TMOUT': '86400', 17:06:50 INFO - 'USER': 'cltbld', 17:06:50 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:50 INFO - '_': '/tools/buildbot/bin/python'} 17:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:50 INFO - Running setup.py (path:/tmp/pip-PLqPV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:51 INFO - Running setup.py (path:/tmp/pip-s5dHs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:51 INFO - Running setup.py (path:/tmp/pip-X6uoC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:51 INFO - Running setup.py (path:/tmp/pip-IeqlDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:51 INFO - Running setup.py (path:/tmp/pip-L2mhQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:51 INFO - Running setup.py (path:/tmp/pip-HwCoBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:51 INFO - Running setup.py (path:/tmp/pip-oHhdBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:51 INFO - Running setup.py (path:/tmp/pip-tg3r6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:51 INFO - Running setup.py (path:/tmp/pip-w9802R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:51 INFO - Running setup.py (path:/tmp/pip-PUNTzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:51 INFO - Running setup.py (path:/tmp/pip-baPBkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:51 INFO - Running setup.py (path:/tmp/pip-InZXkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:51 INFO - Running setup.py (path:/tmp/pip-KE9QlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:51 INFO - Running setup.py (path:/tmp/pip-dhQDqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:51 INFO - Running setup.py (path:/tmp/pip-DmDI8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:52 INFO - Running setup.py (path:/tmp/pip-rG0DPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:52 INFO - Running setup.py (path:/tmp/pip-OEO407-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:52 INFO - Running setup.py install for manifestparser 17:06:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Running setup.py install for mozcrash 17:06:52 INFO - Running setup.py install for mozdebug 17:06:52 INFO - Running setup.py install for mozdevice 17:06:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Running setup.py install for mozfile 17:06:52 INFO - Running setup.py install for mozhttpd 17:06:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Running setup.py install for mozinfo 17:06:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Running setup.py install for mozInstall 17:06:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Running setup.py install for mozleak 17:06:53 INFO - Running setup.py install for mozlog 17:06:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Running setup.py install for moznetwork 17:06:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Running setup.py install for mozprocess 17:06:53 INFO - Running setup.py install for mozprofile 17:06:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Running setup.py install for mozrunner 17:06:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Running setup.py install for mozscreenshot 17:06:53 INFO - Running setup.py install for moztest 17:06:53 INFO - Running setup.py install for mozversion 17:06:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:53 INFO - Cleaning up... 17:06:53 INFO - Return code: 0 17:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', '-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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:53 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 17:06:53 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 17:06:53 INFO - Using env: {'DISPLAY': ':0', 17:06:53 INFO - 'HOME': '/home/cltbld', 17:06:53 INFO - 'LANG': 'en_US.UTF-8', 17:06:53 INFO - 'LANGUAGE': 'en_US:en', 17:06:53 INFO - 'LOGNAME': 'cltbld', 17:06:53 INFO - 'MAIL': '/var/mail/cltbld', 17:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:53 INFO - 'MOZ_NO_REMOTE': '1', 17:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:53 INFO - 'NO_EM_RESTART': '1', 17:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:53 INFO - 'PWD': '/builds/slave/test', 17:06:53 INFO - 'SHELL': '/bin/bash', 17:06:53 INFO - 'SHLVL': '1', 17:06:53 INFO - 'TERM': 'linux', 17:06:53 INFO - 'TMOUT': '86400', 17:06:53 INFO - 'USER': 'cltbld', 17:06:53 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:53 INFO - '_': '/tools/buildbot/bin/python'} 17:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:54 INFO - Running setup.py (path:/tmp/pip-OlL1Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:54 INFO - Running setup.py (path:/tmp/pip-vGLOTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:54 INFO - Running setup.py (path:/tmp/pip-8eLHQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:54 INFO - Running setup.py (path:/tmp/pip-0eOBxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:54 INFO - Running setup.py (path:/tmp/pip-UGKOHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:54 INFO - Running setup.py (path:/tmp/pip-seM2Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:54 INFO - Running setup.py (path:/tmp/pip-mN3h5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:54 INFO - Running setup.py (path:/tmp/pip-qSfpMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:54 INFO - Running setup.py (path:/tmp/pip-X3keoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:54 INFO - Running setup.py (path:/tmp/pip-J7Cm68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:54 INFO - Running setup.py (path:/tmp/pip-oy6NYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:54 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)) 17:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:54 INFO - Running setup.py (path:/tmp/pip-p1Zwzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:55 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)) 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:55 INFO - Running setup.py (path:/tmp/pip-JROMxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:55 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)) 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:55 INFO - Running setup.py (path:/tmp/pip-dAcvdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:55 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)) 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:55 INFO - Running setup.py (path:/tmp/pip-lyxuiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:55 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)) 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:55 INFO - Running setup.py (path:/tmp/pip-K_QkkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:55 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)) 17:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:55 INFO - Running setup.py (path:/tmp/pip-jDJC05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 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)) 17:06:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:55 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 17:06:55 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 17:06:55 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 17:06:55 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 17:06:55 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 17:06:55 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 17:06:57 INFO - Downloading blessings-1.5.1.tar.gz 17:06:57 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 17:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:57 INFO - Installing collected packages: blessings 17:06:57 INFO - Running setup.py install for blessings 17:06:57 INFO - Successfully installed blessings 17:06:57 INFO - Cleaning up... 17:06:57 INFO - Return code: 0 17:06:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:57 INFO - Reading from file tmpfile_stdout 17:06:57 INFO - Current package versions: 17:06:57 INFO - argparse == 1.2.1 17:06:57 INFO - blessings == 1.5.1 17:06:57 INFO - blobuploader == 1.2.4 17:06:57 INFO - docopt == 0.6.1 17:06:57 INFO - manifestparser == 1.1 17:06:57 INFO - mozInstall == 1.12 17:06:57 INFO - mozcrash == 0.16 17:06:57 INFO - mozdebug == 0.1 17:06:57 INFO - mozdevice == 0.47 17:06:57 INFO - mozfile == 1.2 17:06:57 INFO - mozhttpd == 0.7 17:06:57 INFO - mozinfo == 0.9 17:06:57 INFO - mozleak == 0.1 17:06:57 INFO - mozlog == 3.1 17:06:57 INFO - moznetwork == 0.27 17:06:57 INFO - mozprocess == 0.22 17:06:57 INFO - mozprofile == 0.27 17:06:57 INFO - mozrunner == 6.11 17:06:57 INFO - mozscreenshot == 0.1 17:06:57 INFO - mozsystemmonitor == 0.0 17:06:57 INFO - moztest == 0.7 17:06:57 INFO - mozversion == 1.4 17:06:57 INFO - psutil == 3.1.1 17:06:57 INFO - requests == 1.2.3 17:06:57 INFO - wsgiref == 0.1.2 17:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', '-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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06:57 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 17:06:57 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 17:06:57 INFO - Using env: {'DISPLAY': ':0', 17:06:57 INFO - 'HOME': '/home/cltbld', 17:06:57 INFO - 'LANG': 'en_US.UTF-8', 17:06:57 INFO - 'LANGUAGE': 'en_US:en', 17:06:57 INFO - 'LOGNAME': 'cltbld', 17:06:57 INFO - 'MAIL': '/var/mail/cltbld', 17:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:57 INFO - 'MOZ_NO_REMOTE': '1', 17:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:57 INFO - 'NO_EM_RESTART': '1', 17:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:57 INFO - 'PWD': '/builds/slave/test', 17:06:57 INFO - 'SHELL': '/bin/bash', 17:06:57 INFO - 'SHLVL': '1', 17:06:57 INFO - 'TERM': 'linux', 17:06:57 INFO - 'TMOUT': '86400', 17:06:57 INFO - 'USER': 'cltbld', 17:06:57 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:57 INFO - '_': '/tools/buildbot/bin/python'} 17:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 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)) 17:06:57 INFO - Cleaning up... 17:06:57 INFO - Return code: 0 17:06:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:06: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', 'jsonschema'] in /builds/slave/test/build 17:06: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 jsonschema 17:06:57 INFO - Using env: {'DISPLAY': ':0', 17:06:57 INFO - 'HOME': '/home/cltbld', 17:06:57 INFO - 'LANG': 'en_US.UTF-8', 17:06:57 INFO - 'LANGUAGE': 'en_US:en', 17:06:57 INFO - 'LOGNAME': 'cltbld', 17:06:57 INFO - 'MAIL': '/var/mail/cltbld', 17:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:57 INFO - 'MOZ_NO_REMOTE': '1', 17:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:57 INFO - 'NO_EM_RESTART': '1', 17:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:57 INFO - 'PWD': '/builds/slave/test', 17:06:57 INFO - 'SHELL': '/bin/bash', 17:06:57 INFO - 'SHLVL': '1', 17:06:57 INFO - 'TERM': 'linux', 17:06:57 INFO - 'TMOUT': '86400', 17:06:57 INFO - 'USER': 'cltbld', 17:06:57 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:57 INFO - '_': '/tools/buildbot/bin/python'} 17:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:57 INFO - Downloading/unpacking jsonschema 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:59 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 17:06:59 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:59 INFO - warning: no files found matching '*.txt' 17:06:59 INFO - no previously-included directories found matching 'build' 17:06:59 INFO - no previously-included directories found matching 'dist' 17:06:59 INFO - no previously-included directories found matching '.git*' 17:06:59 INFO - Installing collected packages: jsonschema, functools32 17:06:59 INFO - Running setup.py install for functools32 17:07:00 INFO - warning: no files found matching '*.txt' 17:07:00 INFO - no previously-included directories found matching 'build' 17:07:00 INFO - no previously-included directories found matching 'dist' 17:07:00 INFO - no previously-included directories found matching '.git*' 17:07:00 INFO - Successfully installed jsonschema functools32 17:07:00 INFO - Cleaning up... 17:07:00 INFO - Return code: 0 17:07:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:07:00 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')]} 17:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:00 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')]} 17:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:00 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 0x7fd5ac678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', '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 17:07:00 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 17:07:00 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 17:07:00 INFO - Using env: {'DISPLAY': ':0', 17:07:00 INFO - 'HOME': '/home/cltbld', 17:07:00 INFO - 'LANG': 'en_US.UTF-8', 17:07:00 INFO - 'LANGUAGE': 'en_US:en', 17:07:00 INFO - 'LOGNAME': 'cltbld', 17:07:00 INFO - 'MAIL': '/var/mail/cltbld', 17:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:00 INFO - 'MOZ_NO_REMOTE': '1', 17:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:00 INFO - 'NO_EM_RESTART': '1', 17:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:00 INFO - 'PWD': '/builds/slave/test', 17:07:00 INFO - 'SHELL': '/bin/bash', 17:07:00 INFO - 'SHLVL': '1', 17:07:00 INFO - 'TERM': 'linux', 17:07:00 INFO - 'TMOUT': '86400', 17:07:00 INFO - 'USER': 'cltbld', 17:07:00 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:00 INFO - '_': '/tools/buildbot/bin/python'} 17:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:00 INFO - Downloading/unpacking flake8 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:00 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 17:07:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:01 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 17:07:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:02 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 17:07:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:02 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 17:07:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:02 INFO - no previously-included directories found matching 'docs/_build' 17:07:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:02 INFO - Running setup.py install for pep8 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:02 INFO - no previously-included directories found matching 'docs/_build' 17:07:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:07:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:02 INFO - Cleaning up... 17:07:02 INFO - Return code: 0 17:07:02 INFO - Running post-action listener: _resource_record_post_action 17:07:02 INFO - Running post-action listener: _start_resource_monitoring 17:07:02 INFO - Starting resource monitoring. 17:07:02 INFO - ##### 17:07:02 INFO - ##### Running install step. 17:07:02 INFO - ##### 17:07:02 INFO - Running pre-action listener: _resource_record_pre_action 17:07:02 INFO - Running main action method: install 17:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:03 INFO - Reading from file tmpfile_stdout 17:07:03 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:03 INFO - Reading from file tmpfile_stdout 17:07:03 INFO - Output received: 17:07:03 INFO - Usage: mozinstall [options] installer 17:07:03 INFO - Options: 17:07:03 INFO - -h, --help show this help message and exit 17:07:03 INFO - -d DEST, --destination=DEST 17:07:03 INFO - Directory to install application into. [default: 17:07:03 INFO - "/builds/slave/test"] 17:07:03 INFO - --app=APP Application being installed. [default: firefox] 17:07:03 INFO - mkdir: /builds/slave/test/build/application 17:07:03 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'] 17:07:03 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 17:07:17 INFO - Reading from file tmpfile_stdout 17:07:17 INFO - Output received: 17:07:17 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:17 INFO - Running post-action listener: _resource_record_post_action 17:07:17 INFO - ##### 17:07:17 INFO - ##### Running run-tests step. 17:07:17 INFO - ##### 17:07:17 INFO - Running pre-action listener: _resource_record_pre_action 17:07:17 INFO - Running main action method: run_tests 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:17 INFO - Python 2.7.3 17:07:17 INFO - Return code: 0 17:07:17 INFO - grabbing minidump binary from tooltool 17:07:17 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')]} 17:07:17 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 0x25ca0b0>, '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 0x25cafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:17 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 17:07:17 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 17:07:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:17 INFO - Return code: 0 17:07:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:18 INFO - Return code: 0 17:07:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test/build 17:07:18 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 17:07:18 INFO - Using env: {'DISPLAY': ':0', 17:07:18 INFO - 'HOME': '/home/cltbld', 17:07:18 INFO - 'LANG': 'en_US.UTF-8', 17:07:18 INFO - 'LANGUAGE': 'en_US:en', 17:07:18 INFO - 'LOGNAME': 'cltbld', 17:07:18 INFO - 'MAIL': '/var/mail/cltbld', 17:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:18 INFO - 'MOZ_NO_REMOTE': '1', 17:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:18 INFO - 'NO_EM_RESTART': '1', 17:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:18 INFO - 'PWD': '/builds/slave/test', 17:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:18 INFO - 'SHELL': '/bin/bash', 17:07:18 INFO - 'SHLVL': '1', 17:07:18 INFO - 'TERM': 'linux', 17:07:18 INFO - 'TMOUT': '86400', 17:07:18 INFO - 'USER': 'cltbld', 17:07:18 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723', 17:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:18 INFO - '_': '/tools/buildbot/bin/python'} 17:07:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 17:07:18 INFO - mozversion INFO | application_buildid: 20151203160652 17:07:18 INFO - mozversion INFO | application_changeset: 43076a707aeb17df93712d073f8066665c09ee3d 17:07:18 INFO - mozversion INFO | application_display_name: Nightly 17:07:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:18 INFO - mozversion INFO | application_name: Firefox 17:07:18 INFO - mozversion INFO | application_remotingname: firefox 17:07:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:07:18 INFO - mozversion INFO | application_vendor: Mozilla 17:07:18 INFO - mozversion INFO | application_version: 45.0a1 17:07:18 INFO - mozversion INFO | platform_buildid: 20151203160652 17:07:18 INFO - mozversion INFO | platform_changeset: 43076a707aeb17df93712d073f8066665c09ee3d 17:07:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:18 INFO - mozversion INFO | platform_version: 45.0a1 17:07:18 INFO - 2015-12-03 17:07:18,918 DEBUG : using testdate: 1449191238 17:07:18 INFO - 2015-12-03 17:07:18,919 DEBUG : actual date: 1449191238 17:07:18 INFO - 2015-12-03 17:07:18,929 INFO : starting webserver on 'localhost:40088' 17:07:18 INFO - 2015-12-03 17:07:18,930 INFO : Starting test suite talos-linux64-ix-020.e 17:07:18 INFO - 2015-12-03 17:07:18,930 INFO : Starting test dromaeo_css 17:07:18 INFO - 2015-12-03 17:07:18,930 DEBUG : operating with platform_type : linux_ 17:07:18 INFO - 2015-12-03 17:07:18,931 INFO : Initialising browser for dromaeo_css test... 17:07:18 INFO - 2015-12-03 17:07:18,948 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsUsYK/profile http://localhost:40088/getInfo.html 17:07:24 INFO - 2015-12-03 17:07:24,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:24 INFO - 2015-12-03 17:07:24,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:24 INFO - 2015-12-03 17:07:24,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:07:24 INFO - 2015-12-03 17:07:24,018 DEBUG : BROWSER_OUTPUT: __metrics 17:07:24 INFO - 2015-12-03 17:07:24,102 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] 17:07:24 INFO - 2015-12-03 17:07:24,224 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:07:25 INFO - 2015-12-03 17:07:25,120 INFO : Browser initialized. 17:07:25 INFO - 2015-12-03 17:07:25,120 INFO : Running cycle 1/1 for dromaeo_css test... 17:07:25 INFO - 2015-12-03 17:07:25,121 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsUsYK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:37 INFO - 2015-12-03 17:07:37,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 142958592 17:07:37 INFO - 2015-12-03 17:07:37,176 DEBUG : BROWSER_OUTPUT: 17:08:26 INFO - 2015-12-03 17:08:26,827 DEBUG : BROWSER_OUTPUT: 1449191306820 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] 17:10:38 INFO - 2015-12-03 17:10:38,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40088/tests/dromaeo/cssquery-ext.html) 17:10:39 INFO - 2015-12-03 17:10:39,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 144633856 17:10:39 INFO - 2015-12-03 17:10:39,977 DEBUG : BROWSER_OUTPUT: 17:13:42 INFO - 2015-12-03 17:13:42,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-ext.html (next: http://localhost:40088/tests/dromaeo/cssquery-jquery.html) 17:13:42 INFO - 2015-12-03 17:13:42,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 146685952 17:13:42 INFO - 2015-12-03 17:13:42,729 DEBUG : BROWSER_OUTPUT: 17:16:44 INFO - 2015-12-03 17:16:44,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40088/tests/dromaeo/cssquery-mootools.html) 17:16:45 INFO - 2015-12-03 17:16:45,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 145043456 17:16:45 INFO - 2015-12-03 17:16:45,117 DEBUG : BROWSER_OUTPUT: 17:19:46 INFO - 2015-12-03 17:19:46,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40088/tests/dromaeo/cssquery-prototype.html) 17:19:47 INFO - 2015-12-03 17:19:47,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 144150528 17:19:47 INFO - 2015-12-03 17:19:47,498 DEBUG : BROWSER_OUTPUT: 17:22:50 INFO - 2015-12-03 17:22:50,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40088/tests/dromaeo/cssquery-yui.html) 17:22:50 INFO - 2015-12-03 17:22:50,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 144535552 17:22:50 INFO - 2015-12-03 17:22:50,715 DEBUG : BROWSER_OUTPUT: 17:25:52 INFO - 2015-12-03 17:25:52,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-yui.html (next: http://localhost:40088/tests/dromaeo/cssquery-dojo.html) 17:25:53 INFO - 2015-12-03 17:25:53,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 147595264 17:25:53 INFO - 2015-12-03 17:25:53,177 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,177 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2654.389490417204;2693.851838148901;2733;2747.285705716513;2753.655793025871;4482.753448560336;4740.90518189636;4781.258904869746;4816.807327706892;4837.153498137829;4630.328602352665;4661.557152070556;4680.906381872369;4700.553447422498;4728.40894888139;4295.656347492201;4341.066670665807;4409.29451287794;4409.4708634963845;4450.732956022649;4063.1035795350404;4423.867283981485;4433.7118087324225;4436.822527098929;4529.886752831189;4209.97895010526;4315.029118448356;4456.665750068758;4511.984803419237;4537.0925814837;4301.763403012833;4305.289627211507;4314.309710446345;4368.803403846835;4372.322290045048;4308.052228509723;4327.545607711177;4338.631216346615;4365.825366985317;4371.431713877176;4519.096180763828;4617.884552886171;4638.397008388888;4664.626829853603;4704.670673052888;4982.60139188864;5013.623978201649;5062.417821950486;5062.493750624945;5066.323322454095;5055.6713813602;5075.720835354054;5080.974595127001;5087.211482220262;5109.616778741609;4552.931706024346;4674.22875225584;4701.459332176809;4729.479757226668;4745.264484004984;5146.30524879144;5189.117849965515;5206;5223.52988231061;5268.736563171826;5002.449730529639;5007.84976450707;5007.899842003212;5017.799288028511;5051.3433253676785;4883.267509873547;4954.455009948902;5023.673461225008;5077.568406685399;5100.26046223303;5077.923831142536;5088.974555127201;5102.158143906288;5106.463821298785;5111.7699703513435;5078.542931136216;5079.1365467870555;5084.3644544431945;5091.956148989522;5132.28148059272;4033.3546632538655;4098.508179018537;4139.8965025873995;4172.728772629769;4264.829406823692;3679.7056235501095;3685.5208822852856;3710.332140214787;3726.795026273581;3736.065983504124;4358.0412309291905;4367.10474352757;4376.431063961664;4379.211741886491;4416.403785488982;4864.902701946012;4935.975320123376;4957.058158949788;5029.094762942632;5054.469280725544;4313.396124542566;4326.4159338489535;4346.913061738747;4350.717203381833;4379.430674012358;4303.569643035734;4473.239549276631;4481.529439408815;4482.327650852333;4517.954820451753;4692.9530704692515;4723.881902952454;4812.037592481588;4818.638602104786;4853.975730121327;5114.4374118847645;5116.258142569381;5116.488351164854;5143.871403214949;5201.375834899836;4612.331211974312;4721.339012538316;4831.806727730851;4855.805767769391;4915.877103072452;4938.358013458227;5001;5001.64988450805;5017.899642007213;5042.067217564762;5106.234064890296;5118.8976220476125;5120.948790512047;5125.000624878262;5136.666116702402;4696.600788932979;4771.5467030632035;4782.808687652455;4935.580475659609;4959.082569724613;4763.95236047649;4847.418309802846;4854.271859221004;4878.341423907869;4883.658143929891;4808.879778005438;4822.276658501253;4839.274108883696;4860.3195552623365;4894.902101958012;4808.471068182567;4923.040007198562;4935.728534930613;4950.504949505021;4996.325496058131;4748.192807222849;4806.95193048079;4831.661783675109;4868.050730107595;4869.440014398389 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.9102543593024;569.8404446754909;571.2716286734413;571.4399888109655;575.2033433694334;36680.816595917015;36685;36689;36749.81625091871;36997.81501092498;40221.39667904984;40637.59362406375;40818.59181408185;40821;40835.59164408355;7788.610569471518;7961.044674639052;7980.920190798076;7993.200679932019;7993.44045916786;7726.343260822837;7846.843063138734;7875.8424831503335;7883.211678832128;7889.96055019727;7882.5270483771155;7931.0482742071035;7932.405069619773;7948.841023179533;7957.283844453998;7861.764147075597;7930.167332430098;7930.563818990011;7946.960265198666;7950.920490795076;7822.491538050009;7846.489978151459;7880.80297992549;7925.405594580429;7931.167227441151;36272.45591316132;36679.81660091683;36700;37078;37178.44232336517;2666.320088377451;2754.944901101987;2778.360976975307;2796.6224559684388;2826.802123851331;27878.442431151467;28036.43927121446;28273.572112316397;28310.15069547917;28359.432811343657;3357.7649564530493;3501.2647344057777;3520.8591656333715;3538.2215912499464;3584.175639602906;211677;214175.7164856694;214193;214223.92888035616;215257;51489.74255128775;52719.472805271456;54434.18348724773;54532;54783.178252326245;66743.66628166828;67586.32413675898;67820.32179678239;67852.32147678558;67881;13013.674658133434;13110.672233194056;13129.030645403265;13143.408546615425;13163.736725265633;9818.214542836557;9841.803163936682;9852;9906.950465247628;9935.05616966387;19249.499566789073;19725;19773.703394449094;19850;19881.204751809764;7456.32893039629;7740.886325997194;7938.3252423544645;7942.848286998353;7953.801154971056;824.3158178711655;870.1602953150241;893.2585953658448;977.8191034658611;997.7904640025675;26273.73726262751;26674;29660.703392966225;29790;30519.694803051687;944.1125342178331;951.6288647427509;969.3360048366891;1055.482813421418;1059.6503153959175;13956.162630242217;14020.85979140216;14294.499692510712;14316.498922537661;14406.207658578669;311681;319290;320945;321672;324535;47771.522284777406;47812.760936195096;48179;48386.274205886235;48423;1213.9939300303442;1223.0887988448485;1237.7215126596443;1245.2030700351781;1249.0132795091956;25727;26306;26452.73547264503;26552.468950621267;26664.866675666497;41490;41554.58445415507;41594.58405415907;41620.16759664729;41852.581474184866;241686;245442;246392;246826;248131;38778.6122138775;42733;43157.3526397098;43197;43825.78087109544;39996.40005399863;40015;40030.799846000584;40872.978175545846;41125.79437102795;33498.33003339968;34161.658383415845;34248.65751342455;34478.65521344754;34522.65477345295;33605.495917560766;33701.662983370836;34163.31673366469;34237.82881085579;34299.31401372008;34627.65372346244;34644.82677586596;34837.477437837944;35118.64881351256;35189.47215791714;29922.850385747934;30166.84916575403;30441.23896902595;30883.84558077285;30903.227419313796;24515.387115321548;24524.75475245225;24706.382340441633;24731.62902556499;24927.626085608368 17:25:53 INFO - 2015-12-03 17:25:53,178 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.4646845344769;338.95763029621315;340.56407798018546;343.56024288910197;344.9620541740408;15019.09885406875;15132.167730774803;15841.524754257362;15889.841101588981;16476.67046659066;9878.703638890827;10084.34451760635;13068.673283167902;14726.042807217524;14732.558023259293;4386.736795792254;4518.390017347665;4521.344405061264;4679.8596042118625;4956.876078098058;4919.704817710931;4945.975270123644;4948.554630083292;4973.875653108665;4994.625403094764;3317.469204927212;3430.211051458166;4911.140550403683;4937.432195297533;5055.241713742949;5167.224916262553;5180.922286165711;5203.505666961632;5210.374755029402;5211.062008838408;4846.636502262344;5015.14742493777;5016.172331565287;5109;5113.463086375914;18116;18617.16222769965;18689;19154.71267930982;19177.137028833735;1790.7672002639574;1806.4851517317502;1848.3068849181557;1858.1823997441084;1953.8925359105244;9089.227415669677;9220;9870.45712485813;10210.846837297446;13110.344482775823;1697.9830201697948;1734.3842935757878;1766.5053784940237;1771.8228177182307;1772.59230377014;53592.19611705827;54257.1861422079;54275.100371486806;54949.45050549483;55366.44633553694;9592.08875156859;9720;9854;9986.300958932805;10055.396676199305;12525.749485010248;12577.622671319876;12699;12716.872831271754;12745.49018039268;6967.82580435483;7347.88978165328;7393.889091663629;7404.111506619132;7422.591757453392;6916.515843890879;6973.721051157999;6975.093237879145;7144.928260760824;7163.10461192351;4161.854335098257;4180.143070670505;4224.809883555247;4225.7887105644595;4255.042615411569;1705.1303835044216;1769.3718729850718;1783.3669047488215;1793.5516120969758;1811.4565630311117;733.6698485681464;904.5296445848122;931.4830269200523;937.7561833923229;960.6521273362326;13261;14421.855781442051;15108;15723.606909827346;15855.127967961642;797.3302425962104;812.3663542436909;835.3192148399036;849.3332733803934;866.6273502394031;8816.294696424271;9152.496612686233;9155;9195.540222988824;9316.301277404222;439491;449346;449992;450086;461033;66979.99530007054;70263;70363;71520.64239678872;71671.64164179146;818.8567000774841;1065.5897479470304;1065.9893401066045;1070.3203465799274;1077.2943721862193;14329.040174785825;14504.709905802036;14556.126632402089;14635;14966.401343946556;32527.18682032968;32758;33342.49986250257;34043.82978085094;34454.65545344514;42593;42668.57331426646;43294.134117318106;47121.7643911792;48942.51057489379;8581;8719.782005449915;8838.55807209624;8851.336149788664;8959.1936725695;16145.75781363304;16435.342586296414;16619.085950272853;16832.410865619644;16873.831261687224;13699.589012329647;13770.93114534421;13916.930415348263;14108.78836817428;14419.42322307096;12830.871691282968;12885.420156093185;13575;13964.301784910916;14006.229657368942;13084.214947102824;13157.276349800853;13455.259960702255;13740.175589464665;13827.930860345634;8573.957130214309;8758.38691291629;8997.64009439615;8997.730068097968;9058.365914386193;8928.642854285756;9128.726138215865;11374.090072793992;12054.75890482203;12082.45628946717 17:25:53 INFO - 2015-12-03 17:25:53,179 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1413.7596608576541;1454.2659799576793;1464.3190916223953;1571.8270990191077;1659.9087050212238;6687.49843761718;6899.689513971871;7012.614306213156;7061.399781018613;7067.399271061953;7272.818179545514;7336.266373362674;7359.7056117755355;7370.299821516961;7371.078615173104;2034.3795142481538;2054.311805545144;2056.670932650776;2070.27540360874;2079.8752074875556;2083.614531311712;2118.650422680256;2132.7334083239593;2133.018811346775;2134.1890081768906;2018.3339497965635;2108.9050992705365;2110.2508609443657;2124.2034237161065;2136.871787692736;2084.8845867460986;2100.4223838444395;2129.4569884679386;2133.5092928626505;2134.1890081768906;2122.681597760333;2136.743590769118;2143.421276255418;2148.967765483519;2149.48412381029;7107.111611048619;7172.605506697129;7188.424926005907;7200.315969982843;7259.056322678018;4098.077932465201;4163.146554956226;4176.519700234481;4185.455890734215;4186.979065104685;2790.4558611070847;2800.229936767385;2807.6382954267165;2835;2861.4992376334058;878.5036454403306;897.219419105376;899.1682693508544;909.9990010987926;910.9908900910972;9327.580258888367;9427.245820334358;9437.76405589859;9516.524173791351;9543.47510886901;3706.1105334720014;3756.7933763643264;3830;3848.942265866014;3853.344931361675;7531.510451820724;7594.848103037908;7596.924030759732;7599.164091949881;7610.8097297568;4127.5666055064385;4149.3775933609595;4169.478815148106;4170.6653870761065;4195.056112374691;3871.1483473635753;3876.612338766101;3881.437191607201;3917.6082391760597;3920.2355540669864;3091.90724278272;3133.1697100268448;3136.372725454918;3156.179393357698;3157.400093982182;920.7606022434081;925.7130289610243;926.4950601921969;926.8795056642729;934.1359242700474;732.3116270705519;813.9593020349078;926.4672813132341;985.2512090810892;1136.1081550982603;6628.801135965929;6629.569078009914;6633.303503132198;6697.598144111272;6712;570.1960236067125;580.1442871764115;580.1732531143189;586.2759492027343;726.8080348228909;4961.156603377434;5072.746362681851;5092.796288148433;5095.286659867622;5098;8365.58172091393;8814.162654547808;8842.867356989651;8852;8884.156005179497;8725.040245572982;8752.081031491729;8756;8763.956180219058;8800.515971621495;6615.569987950767;6628.5691430056895;6902.447804175755;6920.065791118235;6931.410830079399;6477.935220647733;6488.091667166506;6532.085508028785;6556.541042127005;6568.901466477911;7709.768706938801;7718.498297610638;7801.258880406353;7820.882686759817;7826.647800849089;7919.485233460037;7958.801029974297;7970.362371010189;8084.07033191167;8103.87844182326;5819.679917604572;5863.091220860773;5866.472017518444;5894.2926848778425;6022.126791615104;6914.55055421396;6963.059986901703;6992.895106573304;6999.300069993164;7000.334968178015;6519.5436319457185;6639.502037347315;6664.333566643297;6722.428593569602;6758.2903795102775;5317.707526086102;5602.691851948182;5971.492423144082;6302.747890084345;6382.074599183;6318.747250109944;6328;6344.492440604833;6354.809355719336;6355.491560675043;5887.1757953885635;5910.645361278337;5940.108983652487;5945.554083443672;5961.314448838266;5828.970855145697;5878.29460464747;5879.5002424792665;5906.350301466921;5908.202392676933 17:25:53 INFO - 2015-12-03 17:25:53,180 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.73003741501697;294.7612433928518;296.5033568772306;297.331005238214;298.2305651419338;5523.944760552393;5531.474509921561;5558.166275058743;5611.691356975365;5622.325320961485;5464.0711079116545;5472.20653005314;5478.342598888139;5479.369872464667;5496.972515137429;4251.702380833328;4253.872383828482;4253.893652658678;4258.850940217093;4263.360495925605;4077.673786097105;4166.1251137261215;4214.0307729222295;4227.323628219486;4237.703360764748;4151.252774500589;4167.812448439812;4174.833006679744;4186.351115577075;4190.664746820247;4150.169966006781;4166.375043743433;4177;4177.624013838754;4180.122174343392;3625.909352266188;3627.891163265106;3628;3629.3285742137523;3629.8366573504254;5159.509846564571;5175.327207463006;5302.390225124122;5319.893602127974;5327.360716713981;4797.232442809134;4802.68782529138;4807.471178170398;4810.6151507879285;4810.879728006793;5752.568557358215;5785;5788.797392091299;5790.420957904218;5812.680302583356;3934.075492259317;3940.4483372327895;3946.2699400610977;3948.190620922704;3950.920981580381;5859.44335288147;6068.939310606882;6084.300305464884;6087.665178415185;6100.084987251903;4037.2127435149864;4044.272031034442;4044.6157615026527;4048.4332193492933;4048.5951404859866;4114.979425102915;4115.218108559364;4121.876343709693;4125.608067233608;4131.690123240769;4783.043391321749;4783.736894470838;4787.832425865078;4790.8323208687525;4808.543188397097;5602.271704678447;5777.768889244383;5791.102379131157;5825.88348233033;5843.766249349978;1420.7229590230013;1422.1467119728081;1427.0937954398823;1428.9642758930902;1429.328215738601;929.2658799548282;952.476138124029;956.550421301987;959.947202903833;970.7281961050917;4992.72540010303;5009.7976485643185;5021.171506701354;5028.949710502921;5051.949480505148;6016.669083200379;6029.854327677727;6031.396860314021;6040.335563088057;6046.848828779228;5006.3491746073505;5027.949720502821;5035.62232832539;5045.369328833895;5046.924296135561;3177.0786471923348;3211.2774625709494;3211.6146062472185;3213.3091385351795;3263.7225835804225;5614.9719251403485;5630.634008789416;5634.408387119293;5645.379008309083;5645.915311270334;6049.848753781191;6162.969185154136;6175.567710260329;6217.4715149212825;6260.248770147611;5682.516986056232;5704.515116215168;5707;5722.084466485342;5725.713714314267;6039.698015099139;6047.334793172659;6061.605995610271;6062.636241825505;6070.453659170696;5791.478766910998;5863.384344643751;5923.733431995657;5939.198208241832;5940.198073260054;5670.60305778608;5697.54419646419;5703.116017017369;5712.6286791358425;5712.971665100155;4007.8797636070963;4038.0712436139265;4048.0487085534287;4051.2505186540584;4051.554329023746;6034.366391529002;6045.939540604713;6053.334133245251;6063.090536419572;6072;5612.522935550361;5822.417758224144;5830.708464576839;5832.825015249549;5836.649801011953;5764.19301297827;5782.7686892523825;5783.3638299787835;5798.594098413239;5838.2702162229725;5645.858853528531;5669.064604340238;5689.77240910359;5701.201831743642;5718.3423906249645;5668.404817494269;5870.853228669317;5871.178035075179;5872.471477567039;5873.6211834207215;5709.486146246858;5715.714214289352;5742.08126699726;5744.339400968942;5746.281714785652 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: |5;yui.html;771.4753967302236;773.7059917231453;779.9649015794289;781.3749000799359;793.4009822583948;11843.822342664867;12156.331401772899;12169.452374643151;12250.203736757116;12277.815832762515;11422.885771142306;11631.883681163186;11728.882711172886;11735;11826.58606948757;609.4545381883212;622.9968850155743;768.8001119708888;777.8560966221268;783.0134031120772;774.2064384006383;778.6846327237478;790.8774140008308;791.5646394483011;791.7149826062613;812.6708682983401;813.9470934389275;818.1205204405259;819.901611806584;824.2705205892798;807.6728924785472;809.465752603279;814.6863457568849;816.2205094135116;817.3951276055676;602.593249556552;603.6287683074921;603.7524614907867;604.2748701558148;610.703808652803;11873.762524749456;11980.460879260454;12033.338166400845;12043.397830108459;12074.577389791402;10542.314749541256;11034.724131896766;11484.138689598314;11585.536578536849;11647;9281.30390220736;9429.387089839138;9448.291378146667;9485.905140948571;9492.905070949271;3126.3434678717267;3163.4780261256865;3172.6351469581064;3200.311932934407;3214.019723984184;39705.60294397048;40202.39696404556;40452.59547404518;40490.59509404898;40492.797536012135;9211.447313161232;9242.353035287466;9288;9413.717588472357;9466.242700583936;16801.32794688199;16865.57836054084;16870.15649217534;16896.493105206864;16914.492565223063;6302.873942521215;6342.23893132827;6406.583572067801;6455.548111632234;6507.8698426031215;3390.7287417006582;3522.9295414091575;3563.964360356415;3571.0715214044017;3574.1064733816547;2687.6909155446983;2703.094463354759;2711.2815103997455;2711.7288271172724;2716.293763621473;472.52983281634994;477.08161788557584;483.7605385334212;485.14856426971147;486.8028448478372;523.8664140644112;560.551558752996;561.0798290803086;579.4726798613242;602.9366916473795;7011.901254051579;7154.678039488235;7180.31786980236;7191.964040179766;7230.385417239489;415.56780947814536;422.9429027081366;459.0909998203509;576.8730879206568;593.0659211741438;3590.9461358079648;3592.6766591006935;3722.4974628424816;3729.9254014919547;3735.4396840474146;49110.508894911305;49421.25868111981;49464;49469.752651237235;49611;43875;43887.78056109699;44095.77952110219;44134.70383553994;44384.3342349865;41235.175296494504;41386;41492.170156597305;41576.79211603983;42035.78982105131;7276.126864776261;7326.450516211199;7442.590657513889;7465.3654439371085;7487.288707572772;30484.542731858597;30590.176227971504;30677.23306917345;30895.69104309018;31919.840400798777;35893.6934865527;36516.45225321569;40495.392569110896;40631.18737625172;41383.37924931189;8282.958585207036;8420.915790842013;8715.041345452122;9016.18854303116;9229.538523073954;9174.54127293646;9449.763755905882;9453.149216570542;9523.904760952579;9585.993470685757;8851.69019084329;9003.63985440575;9228.630854765734;9314;9432.151106400457;8898.86651700238;9013.098690130935;9110.863337049817;9185.357025008185;9318.347715659838;8807.779805504913;8851.513166775889;9158.221551168226;9450.952745236229;9530.85703714431;7849.960750196213;8330.79173020655;8343.624536895733;8426.104126571472;8629.439086459612;7997.7600671979935;8112.75661730149;8154.469959452616;8174.101894837524;8337.166283371615 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192353171__endTimestamp 17:25:53 INFO - 2015-12-03 17:25:53,181 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,182 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:25:53 INFO - 2015-12-03 17:25:53,182 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:25:53 INFO - 2015-12-03 17:25:53,182 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,182 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4663.87 Median:4806.95 stddev:489.98 (10.2%) stddev-sans-first:465.43 17:25:53 INFO - 2015-12-03 17:25:53,183 DEBUG : BROWSER_OUTPUT: Values: 2654.4 2693.9 2733.0 2747.3 2753.7 4482.8 4740.9 4781.3 4816.8 4837.2 4630.3 4661.6 4680.9 4700.6 4728.4 4295.7 4341.1 4409.3 4409.5 4450.7 4063.1 4423.9 4433.7 4436.8 4529.9 4210.0 4315.0 4456.7 4512.0 4537.1 4301.8 4305.3 4314.3 4368.8 4372.3 4308.1 4327.5 4338.6 4365.8 4371.4 4519.1 4617.9 4638.4 4664.6 4704.7 4982.6 5013.6 5062.4 5062.5 5066.3 5055.7 5075.7 5081.0 5087.2 5109.6 4552.9 4674.2 4701.5 4729.5 4745.3 5146.3 5189.1 5206.0 5223.5 5268.7 5002.4 5007.8 5007.9 5017.8 5051.3 4883.3 4954.5 5023.7 5077.6 5100.3 5077.9 5089.0 5102.2 5106.5 5111.8 5078.5 5079.1 5084.4 5092.0 5132.3 4033.4 4098.5 4139.9 4172.7 4264.8 3679.7 3685.5 3710.3 3726.8 3736.1 4358.0 4367.1 4376.4 4379.2 4416.4 4864.9 4936.0 4957.1 5029.1 5054.5 4313.4 4326.4 4346.9 4350.7 4379.4 4303.6 4473.2 4481.5 4482.3 4518.0 4693.0 4723.9 4812.0 4818.6 4854.0 5114.4 5116.3 5116.5 5143.9 5201.4 4612.3 4721.3 4831.8 4855.8 4915.9 4938.4 5001.0 5001.6 5017.9 5042.1 5106.2 5118.9 5120.9 5125.0 5136.7 4696.6 4771.5 4782.8 4935.6 4959.1 4764.0 4847.4 4854.3 4878.3 4883.7 4808.9 4822.3 4839.3 4860.3 4894.9 4808.5 4923.0 4935.7 4950.5 4996.3 4748.2 4807.0 4831.7 4868.1 4869.4 17:25:53 INFO - 2015-12-03 17:25:53,183 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,183 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42849.42 Median:36687.00 stddev:68935.57 (187.9%) stddev-sans-first:69055.83 17:25:53 INFO - 2015-12-03 17:25:53,183 DEBUG : BROWSER_OUTPUT: Values: 560.9 569.8 571.3 571.4 575.2 36680.8 36685.0 36689.0 36749.8 36997.8 40221.4 40637.6 40818.6 40821.0 40835.6 7788.6 7961.0 7980.9 7993.2 7993.4 7726.3 7846.8 7875.8 7883.2 7890.0 7882.5 7931.0 7932.4 7948.8 7957.3 7861.8 7930.2 7930.6 7947.0 7950.9 7822.5 7846.5 7880.8 7925.4 7931.2 36272.5 36679.8 36700.0 37078.0 37178.4 2666.3 2754.9 2778.4 2796.6 2826.8 27878.4 28036.4 28273.6 28310.2 28359.4 3357.8 3501.3 3520.9 3538.2 3584.2 211677.0 214175.7 214193.0 214223.9 215257.0 51489.7 52719.5 54434.2 54532.0 54783.2 66743.7 67586.3 67820.3 67852.3 67881.0 13013.7 13110.7 13129.0 13143.4 13163.7 9818.2 9841.8 9852.0 9907.0 9935.1 19249.5 19725.0 19773.7 19850.0 19881.2 7456.3 7740.9 7938.3 7942.8 7953.8 824.3 870.2 893.3 977.8 997.8 26273.7 26674.0 29660.7 29790.0 30519.7 944.1 951.6 969.3 1055.5 1059.7 13956.2 14020.9 14294.5 14316.5 14406.2 311681.0 319290.0 320945.0 321672.0 324535.0 47771.5 47812.8 48179.0 48386.3 48423.0 1214.0 1223.1 1237.7 1245.2 1249.0 25727.0 26306.0 26452.7 26552.5 26664.9 41490.0 41554.6 41594.6 41620.2 41852.6 241686.0 245442.0 246392.0 246826.0 248131.0 38778.6 42733.0 43157.4 43197.0 43825.8 39996.4 40015.0 40030.8 40873.0 41125.8 33498.3 34161.7 34248.7 34478.7 34522.7 33605.5 33701.7 34163.3 34237.8 34299.3 34627.7 34644.8 34837.5 35118.6 35189.5 29922.9 30166.8 30441.2 30883.8 30903.2 24515.4 24524.8 24706.4 24731.6 24927.6 17:25:53 INFO - 2015-12-03 17:25:53,183 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,184 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25229.88 Median:23424.02 stddev:73548.76 (314.0%) stddev-sans-first:73731.33 17:25:53 INFO - 2015-12-03 17:25:53,184 DEBUG : BROWSER_OUTPUT: Values: 331.5 339.0 340.6 343.6 345.0 15019.1 15132.2 15841.5 15889.8 16476.7 9878.7 10084.3 13068.7 14726.0 14732.6 4386.7 4518.4 4521.3 4679.9 4956.9 4919.7 4946.0 4948.6 4973.9 4994.6 3317.5 3430.2 4911.1 4937.4 5055.2 5167.2 5180.9 5203.5 5210.4 5211.1 4846.6 5015.1 5016.2 5109.0 5113.5 18116.0 18617.2 18689.0 19154.7 19177.1 1790.8 1806.5 1848.3 1858.2 1953.9 9089.2 9220.0 9870.5 10210.8 13110.3 1698.0 1734.4 1766.5 1771.8 1772.6 53592.2 54257.2 54275.1 54949.5 55366.4 9592.1 9720.0 9854.0 9986.3 10055.4 12525.7 12577.6 12699.0 12716.9 12745.5 6967.8 7347.9 7393.9 7404.1 7422.6 6916.5 6973.7 6975.1 7144.9 7163.1 4161.9 4180.1 4224.8 4225.8 4255.0 1705.1 1769.4 1783.4 1793.6 1811.5 733.7 904.5 931.5 937.8 960.7 13261.0 14421.9 15108.0 15723.6 15855.1 797.3 812.4 835.3 849.3 866.6 8816.3 9152.5 9155.0 9195.5 9316.3 439491.0 449346.0 449992.0 450086.0 461033.0 66980.0 70263.0 70363.0 71520.6 71671.6 818.9 1065.6 1066.0 1070.3 1077.3 14329.0 14504.7 14556.1 14635.0 14966.4 32527.2 32758.0 33342.5 34043.8 34454.7 42593.0 42668.6 43294.1 47121.8 48942.5 8581.0 8719.8 8838.6 8851.3 8959.2 16145.8 16435.3 16619.1 16832.4 16873.8 13699.6 13770.9 13916.9 14108.8 14419.4 12830.9 12885.4 13575.0 13964.3 14006.2 13084.2 13157.3 13455.3 13740.2 13827.9 8574.0 8758.4 8997.6 8997.7 9058.4 8928.6 9128.7 11374.1 12054.8 12082.5 17:25:53 INFO - 2015-12-03 17:25:53,184 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,184 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4939.42 Median:6336.25 stddev:2596.73 (41.0%) stddev-sans-first:2590.50 17:25:53 INFO - 2015-12-03 17:25:53,185 DEBUG : BROWSER_OUTPUT: Values: 1413.8 1454.3 1464.3 1571.8 1659.9 6687.5 6899.7 7012.6 7061.4 7067.4 7272.8 7336.3 7359.7 7370.3 7371.1 2034.4 2054.3 2056.7 2070.3 2079.9 2083.6 2118.7 2132.7 2133.0 2134.2 2018.3 2108.9 2110.3 2124.2 2136.9 2084.9 2100.4 2129.5 2133.5 2134.2 2122.7 2136.7 2143.4 2149.0 2149.5 7107.1 7172.6 7188.4 7200.3 7259.1 4098.1 4163.1 4176.5 4185.5 4187.0 2790.5 2800.2 2807.6 2835.0 2861.5 878.5 897.2 899.2 910.0 911.0 9327.6 9427.2 9437.8 9516.5 9543.5 3706.1 3756.8 3830.0 3848.9 3853.3 7531.5 7594.8 7596.9 7599.2 7610.8 4127.6 4149.4 4169.5 4170.7 4195.1 3871.1 3876.6 3881.4 3917.6 3920.2 3091.9 3133.2 3136.4 3156.2 3157.4 920.8 925.7 926.5 926.9 934.1 732.3 814.0 926.5 985.3 1136.1 6628.8 6629.6 6633.3 6697.6 6712.0 570.2 580.1 580.2 586.3 726.8 4961.2 5072.7 5092.8 5095.3 5098.0 8365.6 8814.2 8842.9 8852.0 8884.2 8725.0 8752.1 8756.0 8764.0 8800.5 6615.6 6628.6 6902.4 6920.1 6931.4 6477.9 6488.1 6532.1 6556.5 6568.9 7709.8 7718.5 7801.3 7820.9 7826.6 7919.5 7958.8 7970.4 8084.1 8103.9 5819.7 5863.1 5866.5 5894.3 6022.1 6914.6 6963.1 6992.9 6999.3 7000.3 6519.5 6639.5 6664.3 6722.4 6758.3 5317.7 5602.7 5971.5 6302.7 6382.1 6318.7 6328.0 6344.5 6354.8 6355.5 5887.2 5910.6 5940.1 5945.6 5961.3 5829.0 5878.3 5879.5 5906.4 5908.2 17:25:53 INFO - 2015-12-03 17:25:53,185 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,185 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4780.00 Median:5527.71 stddev:1435.45 (26.0%) stddev-sans-first:1399.33 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: Values: 288.7 294.8 296.5 297.3 298.2 5523.9 5531.5 5558.2 5611.7 5622.3 5464.1 5472.2 5478.3 5479.4 5497.0 4251.7 4253.9 4253.9 4258.9 4263.4 4077.7 4166.1 4214.0 4227.3 4237.7 4151.3 4167.8 4174.8 4186.4 4190.7 4150.2 4166.4 4177.0 4177.6 4180.1 3625.9 3627.9 3628.0 3629.3 3629.8 5159.5 5175.3 5302.4 5319.9 5327.4 4797.2 4802.7 4807.5 4810.6 4810.9 5752.6 5785.0 5788.8 5790.4 5812.7 3934.1 3940.4 3946.3 3948.2 3950.9 5859.4 6068.9 6084.3 6087.7 6100.1 4037.2 4044.3 4044.6 4048.4 4048.6 4115.0 4115.2 4121.9 4125.6 4131.7 4783.0 4783.7 4787.8 4790.8 4808.5 5602.3 5777.8 5791.1 5825.9 5843.8 1420.7 1422.1 1427.1 1429.0 1429.3 929.3 952.5 956.6 959.9 970.7 4992.7 5009.8 5021.2 5028.9 5051.9 6016.7 6029.9 6031.4 6040.3 6046.8 5006.3 5027.9 5035.6 5045.4 5046.9 3177.1 3211.3 3211.6 3213.3 3263.7 5615.0 5630.6 5634.4 5645.4 5645.9 6049.8 6163.0 6175.6 6217.5 6260.2 5682.5 5704.5 5707.0 5722.1 5725.7 6039.7 6047.3 6061.6 6062.6 6070.5 5791.5 5863.4 5923.7 5939.2 5940.2 5670.6 5697.5 5703.1 5712.6 5713.0 4007.9 4038.1 4048.0 4051.3 4051.6 6034.4 6045.9 6053.3 6063.1 6072.0 5612.5 5822.4 5830.7 5832.8 5836.6 5764.2 5782.8 5783.4 5798.6 5838.3 5645.9 5669.1 5689.8 5701.2 5718.3 5668.4 5870.9 5871.2 5872.5 5873.6 5709.5 5715.7 5742.1 5744.3 5746.3 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11945.99 Median:603.28 stddev:13819.99 (2290.8%) stddev-sans-first:13833.29 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: Values: 771.5 773.7 780.0 781.4 793.4 11843.8 12156.3 12169.5 12250.2 12277.8 11422.9 11631.9 11728.9 11735.0 11826.6 609.5 623.0 768.8 777.9 783.0 774.2 778.7 790.9 791.6 791.7 812.7 813.9 818.1 819.9 824.3 807.7 809.5 814.7 816.2 817.4 602.6 603.6 603.8 604.3 610.7 11873.8 11980.5 12033.3 12043.4 12074.6 10542.3 11034.7 11484.1 11585.5 11647.0 9281.3 9429.4 9448.3 9485.9 9492.9 3126.3 3163.5 3172.6 3200.3 3214.0 39705.6 40202.4 40452.6 40490.6 40492.8 9211.4 9242.4 9288.0 9413.7 9466.2 16801.3 16865.6 16870.2 16896.5 16914.5 6302.9 6342.2 6406.6 6455.5 6507.9 3390.7 3522.9 3564.0 3571.1 3574.1 2687.7 2703.1 2711.3 2711.7 2716.3 472.5 477.1 483.8 485.1 486.8 523.9 560.6 561.1 579.5 602.9 7011.9 7154.7 7180.3 7192.0 7230.4 415.6 422.9 459.1 576.9 593.1 3590.9 3592.7 3722.5 3729.9 3735.4 49110.5 49421.3 49464.0 49469.8 49611.0 43875.0 43887.8 44095.8 44134.7 44384.3 41235.2 41386.0 41492.2 41576.8 42035.8 7276.1 7326.5 7442.6 7465.4 7487.3 30484.5 30590.2 30677.2 30895.7 31919.8 35893.7 36516.5 40495.4 40631.2 41383.4 8283.0 8420.9 8715.0 9016.2 9229.5 9174.5 9449.8 9453.1 9523.9 9586.0 8851.7 9003.6 9228.6 9314.0 9432.2 8898.9 9013.1 9110.9 9185.4 9318.3 8807.8 8851.5 9158.2 9451.0 9530.9 7850.0 8330.8 8343.6 8426.1 8629.4 7997.8 8112.8 8154.5 8174.1 8337.2 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:25:53 INFO - 2015-12-03 17:25:53,186 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-03 17:25:53,976 INFO : Browser exited with error code: 0 17:25:53 INFO - 2015-12-03 17:25:53,992 INFO : Completed test dromaeo_css (00:18:35) 17:25:53 INFO - 2015-12-03 17:25:53,993 INFO : Starting test kraken 17:25:53 INFO - 2015-12-03 17:25:53,993 DEBUG : operating with platform_type : linux_ 17:25:53 INFO - 2015-12-03 17:25:53,993 INFO : Initialising browser for kraken test... 17:25:53 INFO - 2015-12-03 17:25:53,999 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptN4Pkb/profile http://localhost:40088/getInfo.html 17:25:59 INFO - 2015-12-03 17:25:59,172 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:25:59 INFO - 2015-12-03 17:25:59,172 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:25:59 INFO - 2015-12-03 17:25:59,172 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:25:59 INFO - 2015-12-03 17:25:59,172 DEBUG : BROWSER_OUTPUT: __metrics 17:25:59 INFO - 2015-12-03 17:25:59,309 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] 17:26:00 INFO - 2015-12-03 17:26:00,296 INFO : Browser initialized. 17:26:00 INFO - 2015-12-03 17:26:00,296 INFO : Running cycle 1/1 for kraken test... 17:26:00 INFO - 2015-12-03 17:26:00,296 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptN4Pkb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:12 INFO - 2015-12-03 17:26:12,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 142708736 17:26:12 INFO - 2015-12-03 17:26:12,344 DEBUG : BROWSER_OUTPUT: 17:26:14 INFO - 2015-12-03 17:26:14,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:15 INFO - 2015-12-03 17:26:15,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 17:26:15 INFO - 2015-12-03 17:26:15,535 DEBUG : BROWSER_OUTPUT: 17:26:18 INFO - 2015-12-03 17:26:18,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-dft) 17:26:18 INFO - 2015-12-03 17:26:18,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 143998976 17:26:18 INFO - 2015-12-03 17:26:18,894 DEBUG : BROWSER_OUTPUT: 17:26:21 INFO - 2015-12-03 17:26:21,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-fft) 17:26:22 INFO - 2015-12-03 17:26:22,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 138108928 17:26:22 INFO - 2015-12-03 17:26:22,392 DEBUG : BROWSER_OUTPUT: 17:26:24 INFO - 2015-12-03 17:26:24,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-oscillator) 17:26:25 INFO - 2015-12-03 17:26:25,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 139440128 17:26:25 INFO - 2015-12-03 17:26:25,052 DEBUG : BROWSER_OUTPUT: 17:26:27 INFO - 2015-12-03 17:26:27,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:27 INFO - 2015-12-03 17:26:27,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 17:26:27 INFO - 2015-12-03 17:26:27,896 DEBUG : BROWSER_OUTPUT: 17:26:30 INFO - 2015-12-03 17:26:30,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:31 INFO - 2015-12-03 17:26:31,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 140369920 17:26:31 INFO - 2015-12-03 17:26:31,541 DEBUG : BROWSER_OUTPUT: 17:26:34 INFO - 2015-12-03 17:26:34,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:35 INFO - 2015-12-03 17:26:35,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 17:26:35 INFO - 2015-12-03 17:26:35,600 DEBUG : BROWSER_OUTPUT: 17:26:38 INFO - 2015-12-03 17:26:38,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40088/tests/kraken/driver.html?testName=json-parse-financial) 17:26:39 INFO - 2015-12-03 17:26:39,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 17:26:39 INFO - 2015-12-03 17:26:39,071 DEBUG : BROWSER_OUTPUT: 17:26:40 INFO - 2015-12-03 17:26:40,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:41 INFO - 2015-12-03 17:26:41,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 17:26:41 INFO - 2015-12-03 17:26:41,430 DEBUG : BROWSER_OUTPUT: 17:26:43 INFO - 2015-12-03 17:26:43,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:43 INFO - 2015-12-03 17:26:43,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 141860864 17:26:43 INFO - 2015-12-03 17:26:43,927 DEBUG : BROWSER_OUTPUT: 17:26:46 INFO - 2015-12-03 17:26:46,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:46 INFO - 2015-12-03 17:26:46,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 17:26:46 INFO - 2015-12-03 17:26:46,689 DEBUG : BROWSER_OUTPUT: 17:26:49 INFO - 2015-12-03 17:26:49,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:49 INFO - 2015-12-03 17:26:49,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 141938688 17:26:49 INFO - 2015-12-03 17:26:49,867 DEBUG : BROWSER_OUTPUT: 17:26:52 INFO - 2015-12-03 17:26:52,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:53 INFO - 2015-12-03 17:26:53,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 17:26:53 INFO - 2015-12-03 17:26:53,082 DEBUG : BROWSER_OUTPUT: 17:26:54 INFO - 2015-12-03 17:26:54,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40088/tests/kraken/driver.html?testName=ai-astar) 17:26:55 INFO - 2015-12-03 17:26:55,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 17:26:55 INFO - 2015-12-03 17:26:55,103 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,106 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:26:55 INFO - 2015-12-03 17:26:55,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:26:55 INFO - 2015-12-03 17:26:55,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:26:55 INFO - 2015-12-03 17:26:55,107 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:26:55 INFO - 2015-12-03 17:26:55,107 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;112;111;113;124;112;112;113;112 17:26:55 INFO - 2015-12-03 17:26:55,107 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;171;130;156;173;130;162;157;137;164;132 17:26:55 INFO - 2015-12-03 17:26:55,108 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;163;163;167;166;161;165;162 17:26:55 INFO - 2015-12-03 17:26:55,108 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;135;71;72;72;73;92 17:26:55 INFO - 2015-12-03 17:26:55,108 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;97;136;95;95;94;131;95;95;129 17:26:55 INFO - 2015-12-03 17:26:55,108 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;111;110;110;111;111;111 17:26:55 INFO - 2015-12-03 17:26:55,108 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;148;147;148;147;148 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;99;96;96;97;96;97;96;95 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;73;72;74;72;81;71;70 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;68;68;68;70;68;70;69;68 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;84;85;87;83;84;85;87;85 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;126;132;127;127;126;123;129;134;124 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;148;148;146;145;148;152;147;149;144 17:26:55 INFO - 2015-12-03 17:26:55,109 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;71;71;70;69;70;71;68;67;69 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192415105__endTimestamp 17:26:55 INFO - 2015-12-03 17:26:55,110 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.00 Median:112.50 stddev:4.29 (3.8%) stddev-sans-first:4.54 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 112.0 111.0 113.0 124.0 112.0 112.0 113.0 112.0 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.50 stddev:17.24 (10.8%) stddev-sans-first:16.73 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: Values: 171.0 130.0 156.0 173.0 130.0 162.0 157.0 137.0 164.0 132.0 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.96 (1.2%) stddev-sans-first:2.01 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 163.0 163.0 167.0 166.0 161.0 165.0 162.0 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:20.10 (27.5%) stddev-sans-first:21.13 17:26:55 INFO - 2015-12-03 17:26:55,114 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 135.0 71.0 72.0 72.0 73.0 92.0 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.97 (18.9%) stddev-sans-first:18.52 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: Values: 94.0 97.0 136.0 95.0 95.0 94.0 131.0 95.0 95.0 129.0 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 111.0 110.0 110.0 111.0 111.0 111.0 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 147.0 148.0 17:26:55 INFO - 2015-12-03 17:26:55,115 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 99.0 96.0 96.0 97.0 96.0 97.0 96.0 95.0 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.00 stddev:3.13 (4.3%) stddev-sans-first:3.26 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 73.0 72.0 74.0 72.0 81.0 71.0 70.0 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 68.0 68.0 68.0 70.0 68.0 70.0 69.0 68.0 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.32 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 84.0 85.0 87.0 83.0 84.0 85.0 87.0 85.0 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:3.67 (2.9%) stddev-sans-first:3.57 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: Values: 123.0 126.0 132.0 127.0 127.0 126.0 123.0 129.0 134.0 124.0 17:26:55 INFO - 2015-12-03 17:26:55,116 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:148.00 stddev:2.35 (1.6%) stddev-sans-first:2.35 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: Values: 145.0 148.0 148.0 146.0 145.0 148.0 152.0 147.0 149.0 144.0 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:2.18 (3.1%) stddev-sans-first:1.42 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: Values: 75.0 71.0 71.0 70.0 69.0 70.0 71.0 68.0 67.0 69.0 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:26:55 INFO - 2015-12-03 17:26:55,117 DEBUG : BROWSER_OUTPUT: 17:26:56 INFO - 2015-12-03 17:26:56,112 INFO : Browser exited with error code: 0 17:26:56 INFO - 2015-12-03 17:26:56,161 INFO : Completed test kraken (00:01:02) 17:26:56 INFO - 2015-12-03 17:26:56,161 INFO : Starting test v8_7 17:26:56 INFO - 2015-12-03 17:26:56,161 DEBUG : operating with platform_type : linux_ 17:26:56 INFO - 2015-12-03 17:26:56,161 INFO : Initialising browser for v8_7 test... 17:26:56 INFO - 2015-12-03 17:26:56,167 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWQFSZ/profile http://localhost:40088/getInfo.html 17:27:01 INFO - 2015-12-03 17:27:01,312 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:27:01 INFO - 2015-12-03 17:27:01,312 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:27:01 INFO - 2015-12-03 17:27:01,312 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:27:01 INFO - 2015-12-03 17:27:01,312 DEBUG : BROWSER_OUTPUT: __metrics 17:27:01 INFO - 2015-12-03 17:27:01,453 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] 17:27:02 INFO - 2015-12-03 17:27:02,420 INFO : Browser initialized. 17:27:02 INFO - 2015-12-03 17:27:02,420 INFO : Running cycle 1/1 for v8_7 test... 17:27:02 INFO - 2015-12-03 17:27:02,421 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWQFSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:27:14 INFO - 2015-12-03 17:27:14,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 143556608 17:27:14 INFO - 2015-12-03 17:27:14,478 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-03 17:27:35,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40088/tests/v8_7/run.html (next: http://localhost:40088/tests/v8_7/run.html) 17:27:36 INFO - 2015-12-03 17:27:36,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 138539008 17:27:36 INFO - 2015-12-03 17:27:36,229 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: |0;Richards;167.0564650851988 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.36578171091446 17:27:36 INFO - 2015-12-03 17:27:36,230 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5256.544502617801 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |5;Earley;738.5524372230428 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |8;Splay;589.2751915144372 17:27:36 INFO - 2015-12-03 17:27:36,231 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 17:27:36 INFO - 2015-12-03 17:27:36,232 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:27:36 INFO - 2015-12-03 17:27:36,232 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192456228__endTimestamp 17:27:36 INFO - 2015-12-03 17:27:36,232 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,232 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:27:36 INFO - 2015-12-03 17:27:36,233 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: Values: 167.1 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.37 Median:184.37 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: Values: 184.4 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,234 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: Values: 278.7 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: Values: 5256.5 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,235 DEBUG : BROWSER_OUTPUT: Values: 1060.4 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.55 Median:738.55 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: Values: 738.6 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: Values: 12243.9 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: Values: 26000.0 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:589.28 Median:589.28 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: Values: 589.3 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: Values: 4826.9 17:27:36 INFO - 2015-12-03 17:27:36,236 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:27:36 INFO - 2015-12-03 17:27:36,237 DEBUG : BROWSER_OUTPUT: 17:27:37 INFO - 2015-12-03 17:27:37,220 INFO : Browser exited with error code: 0 17:27:37 INFO - 2015-12-03 17:27:37,235 INFO : Completed test v8_7 (00:00:41) 17:27:37 INFO - 2015-12-03 17:27:37,722 INFO : Completed test suite (00:20:18) 17:27:37 INFO - 2015-12-03 17:27:37,723 DEBUG : Working with test: dromaeo_css 17:27:37 INFO - 2015-12-03 17:27:37,723 DEBUG : Generating results file: dromaeo_css 17:27:37 INFO - 2015-12-03 17:27:37,724 DEBUG : Working with test: kraken 17:27:37 INFO - 2015-12-03 17:27:37,724 DEBUG : Generating results file: kraken 17:27:37 INFO - 2015-12-03 17:27:37,724 INFO : javascript benchmark 17:27:37 INFO - 2015-12-03 17:27:37,724 DEBUG : Working with test: v8_7 17:27:37 INFO - 2015-12-03 17:27:37,725 DEBUG : Generating results file: v8_7 17:27:37 INFO - 2015-12-03 17:27:37,725 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-03 17:27:37,787 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 17:27:37 INFO - 2015-12-03 17:27:37,787 DEBUG : process_Request line: dromaeo_css 6295.49 graph.html#tests=[[72,132,43]] 17:27:37 INFO - 2015-12-03 17:27:37,787 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-03 17:27:37,824 DEBUG : process_Request line: kraken 1539.80 graph.html#tests=[[232,132,43]] 17:27:37 INFO - 2015-12-03 17:27:37,824 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-03 17:27:37,857 DEBUG : process_Request line: v8_7 21329.59 graph.html#tests=[[230,132,43]] 17:27:37 INFO - 2015-12-03 17:27:37,858 INFO : javascript benchmark 17:27:37 INFO - 2015-12-03 17:27:37,862 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.389490417204, 2693.851838148901, 2733.0, 2747.285705716513, 2753.655793025871, 4482.753448560336, 4740.90518189636, 4781.258904869746, 4816.807327706892, 4837.153498137829, 4630.328602352665, 4661.557152070556, 4680.906381872369, 4700.553447422498, 4728.40894888139, 4295.656347492201, 4341.066670665807, 4409.29451287794, 4409.4708634963845, 4450.732956022649, 4063.1035795350404, 4423.867283981485, 4433.7118087324225, 4436.822527098929, 4529.886752831189, 4209.97895010526, 4315.029118448356, 4456.665750068758, 4511.984803419237, 4537.0925814837, 4301.763403012833, 4305.289627211507, 4314.309710446345, 4368.803403846835, 4372.322290045048, 4308.052228509723, 4327.545607711177, 4338.631216346615, 4365.825366985317, 4371.431713877176, 4519.096180763828, 4617.884552886171, 4638.397008388888, 4664.626829853603, 4704.670673052888, 4982.60139188864, 5013.623978201649, 5062.417821950486, 5062.493750624945, 5066.323322454095, 5055.6713813602, 5075.720835354054, 5080.974595127001, 5087.211482220262, 5109.616778741609, 4552.931706024346, 4674.22875225584, 4701.459332176809, 4729.479757226668, 4745.264484004984, 5146.30524879144, 5189.117849965515, 5206.0, 5223.52988231061, 5268.736563171826, 5002.449730529639, 5007.84976450707, 5007.899842003212, 5017.799288028511, 5051.3433253676785, 4883.267509873547, 4954.455009948902, 5023.673461225008, 5077.568406685399, 5100.26046223303, 5077.923831142536, 5088.974555127201, 5102.158143906288, 5106.463821298785, 5111.7699703513435, 5078.542931136216, 5079.1365467870555, 5084.3644544431945, 5091.956148989522, 5132.28148059272, 4033.3546632538655, 4098.508179018537, 4139.8965025873995, 4172.728772629769, 4264.829406823692, 3679.7056235501095, 3685.5208822852856, 3710.332140214787, 3726.795026273581, 3736.065983504124, 4358.0412309291905, 4367.10474352757, 4376.431063961664, 4379.211741886491, 4416.403785488982, 4864.902701946012, 4935.975320123376, 4957.058158949788, 5029.094762942632, 5054.469280725544, 4313.396124542566, 4326.4159338489535, 4346.913061738747, 4350.717203381833, 4379.430674012358, 4303.569643035734, 4473.239549276631, 4481.529439408815, 4482.327650852333, 4517.954820451753, 4692.9530704692515, 4723.881902952454, 4812.037592481588, 4818.638602104786, 4853.975730121327, 5114.4374118847645, 5116.258142569381, 5116.488351164854, 5143.871403214949, 5201.375834899836, 4612.331211974312, 4721.339012538316, 4831.806727730851, 4855.805767769391, 4915.877103072452, 4938.358013458227, 5001.0, 5001.64988450805, 5017.899642007213, 5042.067217564762, 5106.234064890296, 5118.8976220476125, 5120.948790512047, 5125.000624878262, 5136.666116702402, 4696.600788932979, 4771.5467030632035, 4782.808687652455, 4935.580475659609, 4959.082569724613, 4763.95236047649, 4847.418309802846, 4854.271859221004, 4878.341423907869, 4883.658143929891, 4808.879778005438, 4822.276658501253, 4839.274108883696, 4860.3195552623365, 4894.902101958012, 4808.471068182567, 4923.040007198562, 4935.728534930613, 4950.504949505021, 4996.325496058131, 4748.192807222849, 4806.95193048079, 4831.661783675109, 4868.050730107595, 4869.440014398389], "unit": "ms", "name": "dojo.html", "value": 4633.504193071649}, {"lowerIsBetter": false, "replicates": [560.9102543593024, 569.8404446754909, 571.2716286734413, 571.4399888109655, 575.2033433694334, 36680.816595917015, 36685.0, 36689.0, 36749.81625091871, 36997.81501092498, 40221.39667904984, 40637.59362406375, 40818.59181408185, 40821.0, 40835.59164408355, 7788.610569471518, 7961.044674639052, 7980.920190798076, 7993.200679932019, 7993.44045916786, 7726.343260822837, 7846.843063138734, 7875.8424831503335, 7883.211678832128, 7889.96055019727, 7882.5270483771155, 7931.0482742071035, 7932.405069619773, 7948.841023179533, 7957.283844453998, 7861.764147075597, 7930.167332430098, 7930.563818990011, 7946.960265198666, 7950.920490795076, 7822.491538050009, 7846.489978151459, 7880.80297992549, 7925.405594580429, 7931.167227441151, 36272.45591316132, 36679.81660091683, 36700.0, 37078.0, 37178.44232336517, 2666.320088377451, 2754.944901101987, 2778.360976975307, 2796.6224559684388, 2826.802123851331, 27878.442431151467, 28036.43927121446, 28273.572112316397, 28310.15069547917, 28359.432811343657, 3357.7649564530493, 3501.2647344057777, 3520.8591656333715, 3538.2215912499464, 3584.175639602906, 211677.0, 214175.7164856694, 214193.0, 214223.92888035616, 215257.0, 51489.74255128775, 52719.472805271456, 54434.18348724773, 54532.0, 54783.178252326245, 66743.66628166828, 67586.32413675898, 67820.32179678239, 67852.32147678558, 67881.0, 13013.674658133434, 13110.672233194056, 13129.030645403265, 13143.408546615425, 13163.736725265633, 9818.214542836557, 9841.803163936682, 9852.0, 9906.950465247628, 9935.05616966387, 19249.499566789073, 19725.0, 19773.703394449094, 19850.0, 19881.204751809764, 7456.32893039629, 7740.886325997194, 7938.3252423544645, 7942.848286998353, 7953.801154971056, 824.3158178711655, 870.1602953150241, 893.2585953658448, 977.8191034658611, 997.7904640025675, 26273.73726262751, 26674.0, 29660.703392966225, 29790.0, 30519.694803051687, 944.1125342178331, 951.6288647427509, 969.3360048366891, 1055.482813421418, 1059.6503153959175, 13956.162630242217, 14020.85979140216, 14294.499692510712, 14316.498922537661, 14406.207658578669, 311681.0, 319290.0, 320945.0, 321672.0, 324535.0, 47771.522284777406, 47812.760936195096, 48179.0, 48386.274205886235, 48423.0, 1213.9939300303442, 1223.0887988448485, 1237.7215126596443, 1245.2030700351781, 1249.0132795091956, 25727.0, 26306.0, 26452.73547264503, 26552.468950621267, 26664.866675666497, 41490.0, 41554.58445415507, 41594.58405415907, 41620.16759664729, 41852.581474184866, 241686.0, 245442.0, 246392.0, 246826.0, 248131.0, 38778.6122138775, 42733.0, 43157.3526397098, 43197.0, 43825.78087109544, 39996.40005399863, 40015.0, 40030.799846000584, 40872.978175545846, 41125.79437102795, 33498.33003339968, 34161.658383415845, 34248.65751342455, 34478.65521344754, 34522.65477345295, 33605.495917560766, 33701.662983370836, 34163.31673366469, 34237.82881085579, 34299.31401372008, 34627.65372346244, 34644.82677586596, 34837.477437837944, 35118.64881351256, 35189.47215791714, 29922.850385747934, 30166.84916575403, 30441.23896902595, 30883.84558077285, 30903.227419313796, 24515.387115321548, 24524.75475245225, 24706.382340441633, 24731.62902556499, 24927.626085608368], "unit": "ms", "name": "ext.html", "value": 17337.70062113251}, {"lowerIsBetter": false, "replicates": [331.4646845344769, 338.95763029621315, 340.56407798018546, 343.56024288910197, 344.9620541740408, 15019.09885406875, 15132.167730774803, 15841.524754257362, 15889.841101588981, 16476.67046659066, 9878.703638890827, 10084.34451760635, 13068.673283167902, 14726.042807217524, 14732.558023259293, 4386.736795792254, 4518.390017347665, 4521.344405061264, 4679.8596042118625, 4956.876078098058, 4919.704817710931, 4945.975270123644, 4948.554630083292, 4973.875653108665, 4994.625403094764, 3317.469204927212, 3430.211051458166, 4911.140550403683, 4937.432195297533, 5055.241713742949, 5167.224916262553, 5180.922286165711, 5203.505666961632, 5210.374755029402, 5211.062008838408, 4846.636502262344, 5015.14742493777, 5016.172331565287, 5109.0, 5113.463086375914, 18116.0, 18617.16222769965, 18689.0, 19154.71267930982, 19177.137028833735, 1790.7672002639574, 1806.4851517317502, 1848.3068849181557, 1858.1823997441084, 1953.8925359105244, 9089.227415669677, 9220.0, 9870.45712485813, 10210.846837297446, 13110.344482775823, 1697.9830201697948, 1734.3842935757878, 1766.5053784940237, 1771.8228177182307, 1772.59230377014, 53592.19611705827, 54257.1861422079, 54275.100371486806, 54949.45050549483, 55366.44633553694, 9592.08875156859, 9720.0, 9854.0, 9986.300958932805, 10055.396676199305, 12525.749485010248, 12577.622671319876, 12699.0, 12716.872831271754, 12745.49018039268, 6967.82580435483, 7347.88978165328, 7393.889091663629, 7404.111506619132, 7422.591757453392, 6916.515843890879, 6973.721051157999, 6975.093237879145, 7144.928260760824, 7163.10461192351, 4161.854335098257, 4180.143070670505, 4224.809883555247, 4225.7887105644595, 4255.042615411569, 1705.1303835044216, 1769.3718729850718, 1783.3669047488215, 1793.5516120969758, 1811.4565630311117, 733.6698485681464, 904.5296445848122, 931.4830269200523, 937.7561833923229, 960.6521273362326, 13261.0, 14421.855781442051, 15108.0, 15723.606909827346, 15855.127967961642, 797.3302425962104, 812.3663542436909, 835.3192148399036, 849.3332733803934, 866.6273502394031, 8816.294696424271, 9152.496612686233, 9155.0, 9195.540222988824, 9316.301277404222, 439491.0, 449346.0, 449992.0, 450086.0, 461033.0, 66979.99530007054, 70263.0, 70363.0, 71520.64239678872, 71671.64164179146, 818.8567000774841, 1065.5897479470304, 1065.9893401066045, 1070.3203465799274, 1077.2943721862193, 14329.040174785825, 14504.709905802036, 14556.126632402089, 14635.0, 14966.401343946556, 32527.18682032968, 32758.0, 33342.49986250257, 34043.82978085094, 34454.65545344514, 42593.0, 42668.57331426646, 43294.134117318106, 47121.7643911792, 48942.51057489379, 8581.0, 8719.782005449915, 8838.55807209624, 8851.336149788664, 8959.1936725695, 16145.75781363304, 16435.342586296414, 16619.085950272853, 16832.410865619644, 16873.831261687224, 13699.589012329647, 13770.93114534421, 13916.930415348263, 14108.78836817428, 14419.42322307096, 12830.871691282968, 12885.420156093185, 13575.0, 13964.301784910916, 14006.229657368942, 13084.214947102824, 13157.276349800853, 13455.259960702255, 13740.175589464665, 13827.930860345634, 8573.957130214309, 8758.38691291629, 8997.64009439615, 8997.730068097968, 9058.365914386193, 8928.642854285756, 9128.726138215865, 11374.090072793992, 12054.75890482203, 12082.45628946717], "unit": "ms", "name": "jquery.html", "value": 8173.814471250701}, {"lowerIsBetter": false, "replicates": [1413.7596608576541, 1454.2659799576793, 1464.3190916223953, 1571.8270990191077, 1659.9087050212238, 6687.49843761718, 6899.689513971871, 7012.614306213156, 7061.399781018613, 7067.399271061953, 7272.818179545514, 7336.266373362674, 7359.7056117755355, 7370.299821516961, 7371.078615173104, 2034.3795142481538, 2054.311805545144, 2056.670932650776, 2070.27540360874, 2079.8752074875556, 2083.614531311712, 2118.650422680256, 2132.7334083239593, 2133.018811346775, 2134.1890081768906, 2018.3339497965635, 2108.9050992705365, 2110.2508609443657, 2124.2034237161065, 2136.871787692736, 2084.8845867460986, 2100.4223838444395, 2129.4569884679386, 2133.5092928626505, 2134.1890081768906, 2122.681597760333, 2136.743590769118, 2143.421276255418, 2148.967765483519, 2149.48412381029, 7107.111611048619, 7172.605506697129, 7188.424926005907, 7200.315969982843, 7259.056322678018, 4098.077932465201, 4163.146554956226, 4176.519700234481, 4185.455890734215, 4186.979065104685, 2790.4558611070847, 2800.229936767385, 2807.6382954267165, 2835.0, 2861.4992376334058, 878.5036454403306, 897.219419105376, 899.1682693508544, 909.9990010987926, 910.9908900910972, 9327.580258888367, 9427.245820334358, 9437.76405589859, 9516.524173791351, 9543.47510886901, 3706.1105334720014, 3756.7933763643264, 3830.0, 3848.942265866014, 3853.344931361675, 7531.510451820724, 7594.848103037908, 7596.924030759732, 7599.164091949881, 7610.8097297568, 4127.5666055064385, 4149.3775933609595, 4169.478815148106, 4170.6653870761065, 4195.056112374691, 3871.1483473635753, 3876.612338766101, 3881.437191607201, 3917.6082391760597, 3920.2355540669864, 3091.90724278272, 3133.1697100268448, 3136.372725454918, 3156.179393357698, 3157.400093982182, 920.7606022434081, 925.7130289610243, 926.4950601921969, 926.8795056642729, 934.1359242700474, 732.3116270705519, 813.9593020349078, 926.4672813132341, 985.2512090810892, 1136.1081550982603, 6628.801135965929, 6629.569078009914, 6633.303503132198, 6697.598144111272, 6712.0, 570.1960236067125, 580.1442871764115, 580.1732531143189, 586.2759492027343, 726.8080348228909, 4961.156603377434, 5072.746362681851, 5092.796288148433, 5095.286659867622, 5098.0, 8365.58172091393, 8814.162654547808, 8842.867356989651, 8852.0, 8884.156005179497, 8725.040245572982, 8752.081031491729, 8756.0, 8763.956180219058, 8800.515971621495, 6615.569987950767, 6628.5691430056895, 6902.447804175755, 6920.065791118235, 6931.410830079399, 6477.935220647733, 6488.091667166506, 6532.085508028785, 6556.541042127005, 6568.901466477911, 7709.768706938801, 7718.498297610638, 7801.258880406353, 7820.882686759817, 7826.647800849089, 7919.485233460037, 7958.801029974297, 7970.362371010189, 8084.07033191167, 8103.87844182326, 5819.679917604572, 5863.091220860773, 5866.472017518444, 5894.2926848778425, 6022.126791615104, 6914.55055421396, 6963.059986901703, 6992.895106573304, 6999.300069993164, 7000.334968178015, 6519.5436319457185, 6639.502037347315, 6664.333566643297, 6722.428593569602, 6758.2903795102775, 5317.707526086102, 5602.691851948182, 5971.492423144082, 6302.747890084345, 6382.074599183, 6318.747250109944, 6328.0, 6344.492440604833, 6354.809355719336, 6355.491560675043, 5887.1757953885635, 5910.645361278337, 5940.108983652487, 5945.554083443672, 5961.314448838266, 5828.970855145697, 5878.29460464747, 5879.5002424792665, 5906.350301466921, 5908.202392676933], "unit": "ms", "name": "mootools.html", "value": 3993.8907735526304}, {"lowerIsBetter": false, "replicates": [288.73003741501697, 294.7612433928518, 296.5033568772306, 297.331005238214, 298.2305651419338, 5523.944760552393, 5531.474509921561, 5558.166275058743, 5611.691356975365, 5622.325320961485, 5464.0711079116545, 5472.20653005314, 5478.342598888139, 5479.369872464667, 5496.972515137429, 4251.702380833328, 4253.872383828482, 4253.893652658678, 4258.850940217093, 4263.360495925605, 4077.673786097105, 4166.1251137261215, 4214.0307729222295, 4227.323628219486, 4237.703360764748, 4151.252774500589, 4167.812448439812, 4174.833006679744, 4186.351115577075, 4190.664746820247, 4150.169966006781, 4166.375043743433, 4177.0, 4177.624013838754, 4180.122174343392, 3625.909352266188, 3627.891163265106, 3628.0, 3629.3285742137523, 3629.8366573504254, 5159.509846564571, 5175.327207463006, 5302.390225124122, 5319.893602127974, 5327.360716713981, 4797.232442809134, 4802.68782529138, 4807.471178170398, 4810.6151507879285, 4810.879728006793, 5752.568557358215, 5785.0, 5788.797392091299, 5790.420957904218, 5812.680302583356, 3934.075492259317, 3940.4483372327895, 3946.2699400610977, 3948.190620922704, 3950.920981580381, 5859.44335288147, 6068.939310606882, 6084.300305464884, 6087.665178415185, 6100.084987251903, 4037.2127435149864, 4044.272031034442, 4044.6157615026527, 4048.4332193492933, 4048.5951404859866, 4114.979425102915, 4115.218108559364, 4121.876343709693, 4125.608067233608, 4131.690123240769, 4783.043391321749, 4783.736894470838, 4787.832425865078, 4790.8323208687525, 4808.543188397097, 5602.271704678447, 5777.768889244383, 5791.102379131157, 5825.88348233033, 5843.766249349978, 1420.7229590230013, 1422.1467119728081, 1427.0937954398823, 1428.9642758930902, 1429.328215738601, 929.2658799548282, 952.476138124029, 956.550421301987, 959.947202903833, 970.7281961050917, 4992.72540010303, 5009.7976485643185, 5021.171506701354, 5028.949710502921, 5051.949480505148, 6016.669083200379, 6029.854327677727, 6031.396860314021, 6040.335563088057, 6046.848828779228, 5006.3491746073505, 5027.949720502821, 5035.62232832539, 5045.369328833895, 5046.924296135561, 3177.0786471923348, 3211.2774625709494, 3211.6146062472185, 3213.3091385351795, 3263.7225835804225, 5614.9719251403485, 5630.634008789416, 5634.408387119293, 5645.379008309083, 5645.915311270334, 6049.848753781191, 6162.969185154136, 6175.567710260329, 6217.4715149212825, 6260.248770147611, 5682.516986056232, 5704.515116215168, 5707.0, 5722.084466485342, 5725.713714314267, 6039.698015099139, 6047.334793172659, 6061.605995610271, 6062.636241825505, 6070.453659170696, 5791.478766910998, 5863.384344643751, 5923.733431995657, 5939.198208241832, 5940.198073260054, 5670.60305778608, 5697.54419646419, 5703.116017017369, 5712.6286791358425, 5712.971665100155, 4007.8797636070963, 4038.0712436139265, 4048.0487085534287, 4051.2505186540584, 4051.554329023746, 6034.366391529002, 6045.939540604713, 6053.334133245251, 6063.090536419572, 6072.0, 5612.522935550361, 5822.417758224144, 5830.708464576839, 5832.825015249549, 5836.649801011953, 5764.19301297827, 5782.7686892523825, 5783.3638299787835, 5798.594098413239, 5838.2702162229725, 5645.858853528531, 5669.064604340238, 5689.77240910359, 5701.201831743642, 5718.3423906249645, 5668.404817494269, 5870.853228669317, 5871.178035075179, 5872.471477567039, 5873.6211834207215, 5709.486146246858, 5715.714214289352, 5742.08126699726, 5744.339400968942, 5746.281714785652], "unit": "ms", "name": "prototype.html", "value": 4308.216687892672}, {"lowerIsBetter": false, "replicates": [771.4753967302236, 773.7059917231453, 779.9649015794289, 781.3749000799359, 793.4009822583948, 11843.822342664867, 12156.331401772899, 12169.452374643151, 12250.203736757116, 12277.815832762515, 11422.885771142306, 11631.883681163186, 11728.882711172886, 11735.0, 11826.58606948757, 609.4545381883212, 622.9968850155743, 768.8001119708888, 777.8560966221268, 783.0134031120772, 774.2064384006383, 778.6846327237478, 790.8774140008308, 791.5646394483011, 791.7149826062613, 812.6708682983401, 813.9470934389275, 818.1205204405259, 819.901611806584, 824.2705205892798, 807.6728924785472, 809.465752603279, 814.6863457568849, 816.2205094135116, 817.3951276055676, 602.593249556552, 603.6287683074921, 603.7524614907867, 604.2748701558148, 610.703808652803, 11873.762524749456, 11980.460879260454, 12033.338166400845, 12043.397830108459, 12074.577389791402, 10542.314749541256, 11034.724131896766, 11484.138689598314, 11585.536578536849, 11647.0, 9281.30390220736, 9429.387089839138, 9448.291378146667, 9485.905140948571, 9492.905070949271, 3126.3434678717267, 3163.4780261256865, 3172.6351469581064, 3200.311932934407, 3214.019723984184, 39705.60294397048, 40202.39696404556, 40452.59547404518, 40490.59509404898, 40492.797536012135, 9211.447313161232, 9242.353035287466, 9288.0, 9413.717588472357, 9466.242700583936, 16801.32794688199, 16865.57836054084, 16870.15649217534, 16896.493105206864, 16914.492565223063, 6302.873942521215, 6342.23893132827, 6406.583572067801, 6455.548111632234, 6507.8698426031215, 3390.7287417006582, 3522.9295414091575, 3563.964360356415, 3571.0715214044017, 3574.1064733816547, 2687.6909155446983, 2703.094463354759, 2711.2815103997455, 2711.7288271172724, 2716.293763621473, 472.52983281634994, 477.08161788557584, 483.7605385334212, 485.14856426971147, 486.8028448478372, 523.8664140644112, 560.551558752996, 561.0798290803086, 579.4726798613242, 602.9366916473795, 7011.901254051579, 7154.678039488235, 7180.31786980236, 7191.964040179766, 7230.385417239489, 415.56780947814536, 422.9429027081366, 459.0909998203509, 576.8730879206568, 593.0659211741438, 3590.9461358079648, 3592.6766591006935, 3722.4974628424816, 3729.9254014919547, 3735.4396840474146, 49110.508894911305, 49421.25868111981, 49464.0, 49469.752651237235, 49611.0, 43875.0, 43887.78056109699, 44095.77952110219, 44134.70383553994, 44384.3342349865, 41235.175296494504, 41386.0, 41492.170156597305, 41576.79211603983, 42035.78982105131, 7276.126864776261, 7326.450516211199, 7442.590657513889, 7465.3654439371085, 7487.288707572772, 30484.542731858597, 30590.176227971504, 30677.23306917345, 30895.69104309018, 31919.840400798777, 35893.6934865527, 36516.45225321569, 40495.392569110896, 40631.18737625172, 41383.37924931189, 8282.958585207036, 8420.915790842013, 8715.041345452122, 9016.18854303116, 9229.538523073954, 9174.54127293646, 9449.763755905882, 9453.149216570542, 9523.904760952579, 9585.993470685757, 8851.69019084329, 9003.63985440575, 9228.630854765734, 9314.0, 9432.151106400457, 8898.86651700238, 9013.098690130935, 9110.863337049817, 9185.357025008185, 9318.347715659838, 8807.779805504913, 8851.513166775889, 9158.221551168226, 9450.952745236229, 9530.85703714431, 7849.960750196213, 8330.79173020655, 8343.624536895733, 8426.104126571472, 8629.439086459612, 7997.7600671979935, 8112.75661730149, 8154.469959452616, 8174.101894837524, 8337.166283371615], "unit": "ms", "name": "yui.html", "value": 5509.475026846718}], "name": "dromaeo_css", "value": 6295.487355911224}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 112.0, 111.0, 113.0, 124.0, 112.0, 112.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [171.0, 130.0, 156.0, 173.0, 130.0, 162.0, 157.0, 137.0, 164.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 167.0, 166.0, 161.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 135.0, 71.0, 72.0, 72.0, 73.0, 92.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 136.0, 95.0, 95.0, 94.0, 131.0, 95.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 99.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 73.0, 72.0, 74.0, 72.0, 81.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 68.0, 68.0, 70.0, 68.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 85.0, 87.0, 83.0, 84.0, 85.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 132.0, 127.0, 127.0, 126.0, 123.0, 129.0, 134.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [145.0, 148.0, 148.0, 146.0, 145.0, 148.0, 152.0, 147.0, 149.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 71.0, 70.0, 69.0, 70.0, 71.0, 68.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1539.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "Richards", "value": 211.31777200000008}, {"lowerIsBetter": false, "replicates": [184.36578171091446], "unit": "score", "name": "DeltaBlue", "value": 358.6240319999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [738.5524372230428], "unit": "score", "name": "Earley", "value": 902.3909019999996}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [589.2751915144372], "unit": "score", "name": "Splay", "value": 138.29022699999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21329.59373124834}]} 17:27:37 INFO - RETURN: dromaeo_css: 6295.49 17:27:37 INFO - RETURN: kraken: 1539.80 17:27:37 INFO - RETURN: v8_7: 21329.59 17:27:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21329.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1539.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6295.49"}}} 17:27:37 INFO - Return code: 0 17:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:37 INFO - # TBPL SUCCESS # 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - Running post-run listener: _resource_record_post_run 17:27:39 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520040448; Read time: 24; Write time: 909412 17:27:39 INFO - install - Wall time: 15s; CPU: 18.0%; Read bytes: 0; Write bytes: 247508992; Read time: 0; Write time: 626220 17:27:39 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272490496; Read time: 24; Write time: 283192 17:27:39 INFO - Running post-run listener: _upload_blobber_files 17:27:39 INFO - Blob upload gear active. 17:27:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:27:39 INFO - Copying logs to upload dir... 17:27:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.738839 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-03 17:27:39.033149) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:27:39.036865) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010123 build_url: 'https://queue.taskcluster.net/v1/task/1ERS-2XRQw2UOeM80Is-xg/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-03 17:27:39.091936) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:27:39.092721) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449190375.519078-1147188723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:27:39.143150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:27:39.143928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:27:39.144565) ========= ========= Total master_lag: 0.29 =========