builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1449835717.6 results: success (0) buildid: 20151211024841 builduid: cf71a5ab46c04776948334dc1349b5d7 revision: 754b4805a65cab4f3aca99899227acc44ba4fb20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.604460) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.604933) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.605272) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006286 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.632287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.632646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.651541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.651841) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.700882) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.701341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.701774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.702102) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 04:08:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-11 04:08:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.934929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.935276) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.984872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:37.985250) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 754b4805a65cab4f3aca99899227acc44ba4fb20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 754b4805a65cab4f3aca99899227acc44ba4fb20 --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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 04:08:38,140 truncating revision to first 12 chars 2015-12-11 04:08:38,140 Setting DEBUG logging. 2015-12-11 04:08:38,140 attempt 1/10 2015-12-11 04:08:38,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/754b4805a65c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 04:08:38,422 unpacking tar archive at: b2g-inbound-754b4805a65c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:38.561546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:38.561952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:38.571449) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:38.571748) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 04:08:38.572188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-11 04:08:38.572507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:38 INFO - MultiFileLogger online at 20151211 04:08:38 in /builds/slave/test 04:08:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 04:08:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:38 INFO - {'append_to_log': False, 04:08:38 INFO - 'base_work_dir': '/builds/slave/test', 04:08:38 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 04:08:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:38 INFO - 'branch': 'B2G-Inbound-Non-PGO', 04:08:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:38 INFO - 'config_files': ('talos/linux_config.py',), 04:08:38 INFO - 'default_actions': ('clobber', 04:08:38 INFO - 'read-buildbot-config', 04:08:38 INFO - 'download-and-extract', 04:08:38 INFO - 'populate-webroot', 04:08:38 INFO - 'create-virtualenv', 04:08:38 INFO - 'install', 04:08:38 INFO - 'run-tests'), 04:08:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:38 INFO - 'download_minidump_stackwalk': True, 04:08:38 INFO - 'download_symbols': 'ondemand', 04:08:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:38 INFO - 'installer_path': 'installer.exe', 04:08:38 INFO - 'log_level': 'info', 04:08:38 INFO - 'log_name': 'talos', 04:08:38 INFO - 'log_to_console': True, 04:08:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:38 INFO - 'opt_config_files': (), 04:08:38 INFO - 'pip_index': False, 04:08:38 INFO - 'sps_profile': False, 04:08:38 INFO - 'sps_profile_interval': 0, 04:08:38 INFO - 'suite': 'dromaeojs', 04:08:38 INFO - 'system_bits': '64', 04:08:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:38 INFO - 'title': 'talos-linux64-ix-001', 04:08:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:38 INFO - 'use_talos_json': True, 04:08:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:38 INFO - 'work_dir': 'build'} 04:08:38 INFO - ##### 04:08:38 INFO - ##### Running clobber step. 04:08:38 INFO - ##### 04:08:38 INFO - Running pre-action listener: _resource_record_pre_action 04:08:38 INFO - Running main action method: clobber 04:08:38 INFO - rmtree: /builds/slave/test/build 04:08:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:39 INFO - Running post-action listener: _resource_record_post_action 04:08:39 INFO - ##### 04:08:39 INFO - ##### Running read-buildbot-config step. 04:08:39 INFO - ##### 04:08:39 INFO - Running pre-action listener: _resource_record_pre_action 04:08:39 INFO - Running main action method: read_buildbot_config 04:08:39 INFO - Using buildbot properties: 04:08:39 INFO - { 04:08:39 INFO - "properties": { 04:08:39 INFO - "buildnumber": 783, 04:08:39 INFO - "product": "firefox", 04:08:39 INFO - "script_repo_revision": "production", 04:08:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:08:39 INFO - "repository": "", 04:08:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 04:08:39 INFO - "buildid": "20151211024841", 04:08:39 INFO - "slavename": "talos-linux64-ix-001", 04:08:39 INFO - "pgo_build": "False", 04:08:39 INFO - "basedir": "/builds/slave/test", 04:08:39 INFO - "project": "", 04:08:39 INFO - "platform": "ubuntu64_hw", 04:08:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:08:39 INFO - "slavebuilddir": "test", 04:08:39 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 04:08:39 INFO - "branch": "b2g-inbound", 04:08:39 INFO - "repo_path": "integration/b2g-inbound", 04:08:39 INFO - "stage_platform": "linux64", 04:08:39 INFO - "builduid": "cf71a5ab46c04776948334dc1349b5d7", 04:08:39 INFO - "revision": "754b4805a65cab4f3aca99899227acc44ba4fb20" 04:08:39 INFO - }, 04:08:39 INFO - "sourcestamp": { 04:08:39 INFO - "repository": "", 04:08:39 INFO - "hasPatch": false, 04:08:39 INFO - "project": "", 04:08:39 INFO - "branch": "b2g-inbound-linux64-talos", 04:08:39 INFO - "changes": [ 04:08:39 INFO - { 04:08:39 INFO - "category": null, 04:08:39 INFO - "files": [ 04:08:39 INFO - { 04:08:39 INFO - "url": null, 04:08:39 INFO - "name": "https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:08:39 INFO - } 04:08:39 INFO - ], 04:08:39 INFO - "repository": "", 04:08:39 INFO - "rev": "754b4805a65cab4f3aca99899227acc44ba4fb20", 04:08:39 INFO - "who": "cbook@mozilla.com", 04:08:39 INFO - "when": 1449835713, 04:08:39 INFO - "number": 7328345, 04:08:39 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:08:39 INFO - "project": "", 04:08:39 INFO - "at": "Fri 11 Dec 2015 04:08:33", 04:08:39 INFO - "branch": "b2g-inbound-linux64-talos", 04:08:39 INFO - "revlink": "", 04:08:39 INFO - "properties": [ 04:08:39 INFO - [ 04:08:39 INFO - "buildid", 04:08:39 INFO - "20151211024841", 04:08:39 INFO - "Change" 04:08:39 INFO - ], 04:08:39 INFO - [ 04:08:39 INFO - "builduid", 04:08:39 INFO - "cf71a5ab46c04776948334dc1349b5d7", 04:08:39 INFO - "Change" 04:08:39 INFO - ], 04:08:39 INFO - [ 04:08:39 INFO - "pgo_build", 04:08:39 INFO - "False", 04:08:39 INFO - "Change" 04:08:39 INFO - ] 04:08:39 INFO - ], 04:08:39 INFO - "revision": "754b4805a65cab4f3aca99899227acc44ba4fb20" 04:08:39 INFO - } 04:08:39 INFO - ], 04:08:39 INFO - "revision": "754b4805a65cab4f3aca99899227acc44ba4fb20" 04:08:39 INFO - } 04:08:39 INFO - } 04:08:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:08:39 INFO - Running post-action listener: _resource_record_post_action 04:08:39 INFO - ##### 04:08:39 INFO - ##### Running download-and-extract step. 04:08:39 INFO - ##### 04:08:39 INFO - Running pre-action listener: _resource_record_pre_action 04:08:39 INFO - Running main action method: download_and_extract 04:08:39 INFO - mkdir: /builds/slave/test/build/tests 04:08:39 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')]} 04:08:39 INFO - https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/test_packages.json 04:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/test_packages.json 04:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:08:39 INFO - Downloaded 1302 bytes. 04:08:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:08:39 INFO - Using the following test package requirements: 04:08:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'jsshell-linux-x86_64.zip'], 04:08:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:39 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')]} 04:08:39 INFO - https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:41 INFO - Downloaded 21873828 bytes. 04:08:41 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 04:08:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:41 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 04:08:42 INFO - Return code: 0 04:08:42 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 04:08: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')]} 04:08:42 INFO - https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:44 INFO - Downloaded 21873828 bytes. 04:08:44 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 04:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:08:44 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 04:08:46 INFO - Return code: 0 04:08:46 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')]} 04:08:46 INFO - https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:47 INFO - Downloaded 11132038 bytes. 04:08:47 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 04:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:47 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 04:08:48 INFO - Return code: 0 04:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:48 INFO - https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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 04:08:54 INFO - Downloaded 57730750 bytes. 04:08:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:08:54 INFO - mkdir: /builds/slave/test/properties 04:08:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:54 INFO - Contents: 04:08:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:08:54 INFO - Running post-action listener: _resource_record_post_action 04:08:54 INFO - Running post-action listener: set_extra_try_arguments 04:08:54 INFO - ##### 04:08:54 INFO - ##### Running populate-webroot step. 04:08:54 INFO - ##### 04:08:54 INFO - Running pre-action listener: _resource_record_pre_action 04:08:54 INFO - Running main action method: populate_webroot 04:08:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:54 INFO - '--tppagecycles', 04:08:54 INFO - '7'], 04:08:54 INFO - 'tests': ['tsvgm']}}, 04:08:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'tests': ['damp', 'tps']}, 04:08:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['damp', 'tps']}, 04:08:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:54 INFO - 'other': {'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'other_l64': {'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:54 INFO - 'ts_paint', 04:08:54 INFO - 'tpaint', 04:08:54 INFO - 'sessionrestore', 04:08:54 INFO - 'sessionrestore_no_auto_restore']}, 04:08:54 INFO - 'svgr': {'tests': ['tsvgx', 04:08:54 INFO - 'tsvgr_opacity', 04:08:54 INFO - 'tart', 04:08:54 INFO - 'tscrollx', 04:08:54 INFO - 'cart']}, 04:08:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['tsvgx', 04:08:54 INFO - 'tsvgr_opacity', 04:08:54 INFO - 'tart', 04:08:54 INFO - 'tscrollx', 04:08:54 INFO - 'cart']}, 04:08:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'tests': ['tp5o']}, 04:08:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'talos_options': ['--e10s'], 04:08:54 INFO - 'tests': ['tp5o']}, 04:08:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'talos_options': ['--xperf_path', 04:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:54 INFO - 'tests': ['tp5n']}, 04:08:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:54 INFO - 'talos_options': ['--e10s', 04:08:54 INFO - '--xperf_path', 04:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:54 INFO - 'tests': ['tp5n']}}, 04:08:54 INFO - 'talos.zip': {'path': '', 04:08:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:54 INFO - Running post-action listener: _resource_record_post_action 04:08:54 INFO - ##### 04:08:54 INFO - ##### Running create-virtualenv step. 04:08:54 INFO - ##### 04:08:54 INFO - Running pre-action listener: _resource_record_pre_action 04:08:54 INFO - Running main action method: create_virtualenv 04:08:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:54 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 04:08:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:54 INFO - Using real prefix '/usr' 04:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:56 INFO - Installing pip.................done. 04:08:56 INFO - Return code: 0 04:08:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:56 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')]} 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:56 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')]} 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:56 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:08:56 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 04:08:56 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 04:08:56 INFO - Using env: {'DISPLAY': ':0', 04:08:56 INFO - 'HOME': '/home/cltbld', 04:08:56 INFO - 'LANG': 'en_US.UTF-8', 04:08:56 INFO - 'LANGUAGE': 'en_US:en', 04:08:56 INFO - 'LOGNAME': 'cltbld', 04:08:56 INFO - 'MAIL': '/var/mail/cltbld', 04:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:56 INFO - 'MOZ_NO_REMOTE': '1', 04:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:56 INFO - 'NO_EM_RESTART': '1', 04:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:56 INFO - 'PWD': '/builds/slave/test', 04:08:56 INFO - 'SHELL': '/bin/bash', 04:08:56 INFO - 'SHLVL': '1', 04:08:56 INFO - 'TERM': 'linux', 04:08:56 INFO - 'TMOUT': '86400', 04:08:56 INFO - 'USER': 'cltbld', 04:08:56 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:56 INFO - '_': '/tools/buildbot/bin/python'} 04:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:57 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 04:08:57 INFO - Cleaning up... 04:08:57 INFO - Return code: 0 04:08:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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', '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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:08: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 psutil>=0.7.1 04:08:57 INFO - Using env: {'DISPLAY': ':0', 04:08:57 INFO - 'HOME': '/home/cltbld', 04:08:57 INFO - 'LANG': 'en_US.UTF-8', 04:08:57 INFO - 'LANGUAGE': 'en_US:en', 04:08:57 INFO - 'LOGNAME': 'cltbld', 04:08:57 INFO - 'MAIL': '/var/mail/cltbld', 04:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:57 INFO - 'MOZ_NO_REMOTE': '1', 04:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:57 INFO - 'NO_EM_RESTART': '1', 04:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:57 INFO - 'PWD': '/builds/slave/test', 04:08:57 INFO - 'SHELL': '/bin/bash', 04:08:57 INFO - 'SHLVL': '1', 04:08:57 INFO - 'TERM': 'linux', 04:08:57 INFO - 'TMOUT': '86400', 04:08:57 INFO - 'USER': 'cltbld', 04:08:57 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:57 INFO - '_': '/tools/buildbot/bin/python'} 04:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:57 INFO - Downloading/unpacking psutil>=0.7.1 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:59 INFO - Installing collected packages: psutil 04:08:59 INFO - Running setup.py install for psutil 04:08:59 INFO - building 'psutil._psutil_linux' extension 04:08:59 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 04:08:59 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 04:08:59 INFO - building 'psutil._psutil_posix' extension 04:08:59 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 04:08:59 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 04:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:59 INFO - Successfully installed psutil 04:08:59 INFO - Cleaning up... 04:08:59 INFO - Return code: 0 04:08:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:08:59 INFO - Using env: {'DISPLAY': ':0', 04:08:59 INFO - 'HOME': '/home/cltbld', 04:08:59 INFO - 'LANG': 'en_US.UTF-8', 04:08:59 INFO - 'LANGUAGE': 'en_US:en', 04:08:59 INFO - 'LOGNAME': 'cltbld', 04:08:59 INFO - 'MAIL': '/var/mail/cltbld', 04:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:59 INFO - 'MOZ_NO_REMOTE': '1', 04:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:59 INFO - 'NO_EM_RESTART': '1', 04:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:59 INFO - 'PWD': '/builds/slave/test', 04:08:59 INFO - 'SHELL': '/bin/bash', 04:08:59 INFO - 'SHLVL': '1', 04:08:59 INFO - 'TERM': 'linux', 04:08:59 INFO - 'TMOUT': '86400', 04:08:59 INFO - 'USER': 'cltbld', 04:08:59 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:59 INFO - '_': '/tools/buildbot/bin/python'} 04:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:09:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:01 INFO - Installing collected packages: mozsystemmonitor 04:09:01 INFO - Running setup.py install for mozsystemmonitor 04:09:01 INFO - Successfully installed mozsystemmonitor 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:01 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')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:01 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 04:09:01 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 04:09:01 INFO - Using env: {'DISPLAY': ':0', 04:09:01 INFO - 'HOME': '/home/cltbld', 04:09:01 INFO - 'LANG': 'en_US.UTF-8', 04:09:01 INFO - 'LANGUAGE': 'en_US:en', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MAIL': '/var/mail/cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SHLVL': '1', 04:09:01 INFO - 'TERM': 'linux', 04:09:01 INFO - 'TMOUT': '86400', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - '_': '/tools/buildbot/bin/python'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:03 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 04:09:03 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 04:09:03 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 04:09:03 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 04:09:03 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 04:09:03 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 04:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 INFO - Downloading docopt-0.6.1.tar.gz 04:09:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:04 INFO - Running setup.py install for blobuploader 04:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:04 INFO - Running setup.py install for requests 04:09:04 INFO - Running setup.py install for docopt 04:09:04 INFO - Successfully installed blobuploader requests docopt 04:09:04 INFO - Cleaning up... 04:09:04 INFO - Return code: 0 04:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:04 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')]} 04:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:04 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')]} 04:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:04 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:04 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 04:09:04 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 04:09:04 INFO - Using env: {'DISPLAY': ':0', 04:09:04 INFO - 'HOME': '/home/cltbld', 04:09:04 INFO - 'LANG': 'en_US.UTF-8', 04:09:04 INFO - 'LANGUAGE': 'en_US:en', 04:09:04 INFO - 'LOGNAME': 'cltbld', 04:09:04 INFO - 'MAIL': '/var/mail/cltbld', 04:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:04 INFO - 'MOZ_NO_REMOTE': '1', 04:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:04 INFO - 'NO_EM_RESTART': '1', 04:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:04 INFO - 'PWD': '/builds/slave/test', 04:09:04 INFO - 'SHELL': '/bin/bash', 04:09:04 INFO - 'SHLVL': '1', 04:09:04 INFO - 'TERM': 'linux', 04:09:04 INFO - 'TMOUT': '86400', 04:09:04 INFO - 'USER': 'cltbld', 04:09:04 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:04 INFO - '_': '/tools/buildbot/bin/python'} 04:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:05 INFO - Running setup.py (path:/tmp/pip-JyjNTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:05 INFO - Running setup.py (path:/tmp/pip-Xm29iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:05 INFO - Running setup.py (path:/tmp/pip-eg6OLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:05 INFO - Running setup.py (path:/tmp/pip-G5iIJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:05 INFO - Running setup.py (path:/tmp/pip-JV5RdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:05 INFO - Running setup.py (path:/tmp/pip-DCzv2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:05 INFO - Running setup.py (path:/tmp/pip-zVwB65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:05 INFO - Running setup.py (path:/tmp/pip-98Aeiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:05 INFO - Running setup.py (path:/tmp/pip-TJhgZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:05 INFO - Running setup.py (path:/tmp/pip-_Q0GF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:05 INFO - Running setup.py (path:/tmp/pip-VYVwoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:05 INFO - Running setup.py (path:/tmp/pip-LQUOvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:06 INFO - Running setup.py (path:/tmp/pip-yoZcnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:06 INFO - Running setup.py (path:/tmp/pip-MGTNP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:06 INFO - Running setup.py (path:/tmp/pip-6gLmK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:06 INFO - Running setup.py (path:/tmp/pip-zBFtpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:06 INFO - Running setup.py (path:/tmp/pip-sw_933-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:06 INFO - Running setup.py install for manifestparser 04:09:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:06 INFO - Running setup.py install for mozcrash 04:09:06 INFO - Running setup.py install for mozdebug 04:09:06 INFO - Running setup.py install for mozdevice 04:09:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:06 INFO - Running setup.py install for mozfile 04:09:06 INFO - Running setup.py install for mozhttpd 04:09:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:06 INFO - Running setup.py install for mozinfo 04:09:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for mozInstall 04:09:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for mozleak 04:09:07 INFO - Running setup.py install for mozlog 04:09:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for moznetwork 04:09:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for mozprocess 04:09:07 INFO - Running setup.py install for mozprofile 04:09:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for mozrunner 04:09:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:07 INFO - Running setup.py install for mozscreenshot 04:09:07 INFO - Running setup.py install for moztest 04:09:08 INFO - Running setup.py install for mozversion 04:09:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:08 INFO - Cleaning up... 04:09:08 INFO - Return code: 0 04:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:08 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:08 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 04:09:08 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 04:09:08 INFO - Using env: {'DISPLAY': ':0', 04:09:08 INFO - 'HOME': '/home/cltbld', 04:09:08 INFO - 'LANG': 'en_US.UTF-8', 04:09:08 INFO - 'LANGUAGE': 'en_US:en', 04:09:08 INFO - 'LOGNAME': 'cltbld', 04:09:08 INFO - 'MAIL': '/var/mail/cltbld', 04:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:08 INFO - 'MOZ_NO_REMOTE': '1', 04:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:08 INFO - 'NO_EM_RESTART': '1', 04:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:08 INFO - 'PWD': '/builds/slave/test', 04:09:08 INFO - 'SHELL': '/bin/bash', 04:09:08 INFO - 'SHLVL': '1', 04:09:08 INFO - 'TERM': 'linux', 04:09:08 INFO - 'TMOUT': '86400', 04:09:08 INFO - 'USER': 'cltbld', 04:09:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:08 INFO - '_': '/tools/buildbot/bin/python'} 04:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:08 INFO - Running setup.py (path:/tmp/pip-4SiJke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:08 INFO - Running setup.py (path:/tmp/pip-ILl4f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:08 INFO - Running setup.py (path:/tmp/pip-PLNAp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:08 INFO - Running setup.py (path:/tmp/pip-TNkktR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:08 INFO - Running setup.py (path:/tmp/pip-k9VHlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:08 INFO - Running setup.py (path:/tmp/pip-9sZ7Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:08 INFO - Running setup.py (path:/tmp/pip-0ElGsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:08 INFO - Running setup.py (path:/tmp/pip-_Iw5Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:08 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)) 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:08 INFO - Running setup.py (path:/tmp/pip-i_7F5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:09 INFO - Running setup.py (path:/tmp/pip-NrIZiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:09 INFO - Running setup.py (path:/tmp/pip-r5V30_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:09 INFO - Running setup.py (path:/tmp/pip-wHyNSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:09 INFO - Running setup.py (path:/tmp/pip-j58MOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:09 INFO - Running setup.py (path:/tmp/pip-5fOIAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:09 INFO - Running setup.py (path:/tmp/pip-TJbM71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:09 INFO - Running setup.py (path:/tmp/pip-EAho4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:09 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)) 04:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:09 INFO - Running setup.py (path:/tmp/pip-9BWpSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:09 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)) 04:09:09 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)) 04:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:09 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)) 04:09:09 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)) 04:09:09 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)) 04:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:09 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 04:09:09 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 04:09:09 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 04:09:09 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 04:09:09 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 04:09:09 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 04:09:11 INFO - Downloading blessings-1.5.1.tar.gz 04:09:11 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 04:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:11 INFO - Installing collected packages: blessings 04:09:11 INFO - Running setup.py install for blessings 04:09:11 INFO - Successfully installed blessings 04:09:11 INFO - Cleaning up... 04:09:11 INFO - Return code: 0 04:09:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:11 INFO - Reading from file tmpfile_stdout 04:09:11 INFO - Current package versions: 04:09:11 INFO - argparse == 1.2.1 04:09:11 INFO - blessings == 1.5.1 04:09:11 INFO - blobuploader == 1.2.4 04:09:11 INFO - docopt == 0.6.1 04:09:11 INFO - manifestparser == 1.1 04:09:11 INFO - mozInstall == 1.12 04:09:11 INFO - mozcrash == 0.16 04:09:11 INFO - mozdebug == 0.1 04:09:11 INFO - mozdevice == 0.47 04:09:11 INFO - mozfile == 1.2 04:09:11 INFO - mozhttpd == 0.7 04:09:11 INFO - mozinfo == 0.9 04:09:11 INFO - mozleak == 0.1 04:09:11 INFO - mozlog == 3.1 04:09:11 INFO - moznetwork == 0.27 04:09:11 INFO - mozprocess == 0.22 04:09:11 INFO - mozprofile == 0.27 04:09:11 INFO - mozrunner == 6.11 04:09:11 INFO - mozscreenshot == 0.1 04:09:11 INFO - mozsystemmonitor == 0.0 04:09:11 INFO - moztest == 0.7 04:09:11 INFO - mozversion == 1.4 04:09:11 INFO - psutil == 3.1.1 04:09:11 INFO - requests == 1.2.3 04:09:11 INFO - wsgiref == 0.1.2 04:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:11 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')]} 04:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 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')]} 04:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:11 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 04:09:11 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 04:09:11 INFO - Using env: {'DISPLAY': ':0', 04:09:11 INFO - 'HOME': '/home/cltbld', 04:09:11 INFO - 'LANG': 'en_US.UTF-8', 04:09:11 INFO - 'LANGUAGE': 'en_US:en', 04:09:11 INFO - 'LOGNAME': 'cltbld', 04:09:11 INFO - 'MAIL': '/var/mail/cltbld', 04:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:11 INFO - 'MOZ_NO_REMOTE': '1', 04:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:11 INFO - 'NO_EM_RESTART': '1', 04:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:11 INFO - 'PWD': '/builds/slave/test', 04:09:11 INFO - 'SHELL': '/bin/bash', 04:09:11 INFO - 'SHLVL': '1', 04:09:11 INFO - 'TERM': 'linux', 04:09:11 INFO - 'TMOUT': '86400', 04:09:11 INFO - 'USER': 'cltbld', 04:09:11 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:11 INFO - '_': '/tools/buildbot/bin/python'} 04:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 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)) 04:09:11 INFO - Cleaning up... 04:09:11 INFO - Return code: 0 04:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:11 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')]} 04:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 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')]} 04:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:11 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 04:09:11 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 04:09:11 INFO - Using env: {'DISPLAY': ':0', 04:09:11 INFO - 'HOME': '/home/cltbld', 04:09:11 INFO - 'LANG': 'en_US.UTF-8', 04:09:11 INFO - 'LANGUAGE': 'en_US:en', 04:09:11 INFO - 'LOGNAME': 'cltbld', 04:09:11 INFO - 'MAIL': '/var/mail/cltbld', 04:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:11 INFO - 'MOZ_NO_REMOTE': '1', 04:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:11 INFO - 'NO_EM_RESTART': '1', 04:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:11 INFO - 'PWD': '/builds/slave/test', 04:09:11 INFO - 'SHELL': '/bin/bash', 04:09:11 INFO - 'SHLVL': '1', 04:09:11 INFO - 'TERM': 'linux', 04:09:11 INFO - 'TMOUT': '86400', 04:09:11 INFO - 'USER': 'cltbld', 04:09:11 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:11 INFO - '_': '/tools/buildbot/bin/python'} 04:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:12 INFO - Downloading/unpacking jsonschema 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:13 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 04:09:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:13 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 04:09:13 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 04:09:13 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 04:09:13 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 04:09:13 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 04:09:13 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 04:09:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:14 INFO - warning: no files found matching '*.txt' 04:09:14 INFO - no previously-included directories found matching 'build' 04:09:14 INFO - no previously-included directories found matching 'dist' 04:09:14 INFO - no previously-included directories found matching '.git*' 04:09:14 INFO - Installing collected packages: jsonschema, functools32 04:09:14 INFO - Running setup.py install for functools32 04:09:14 INFO - warning: no files found matching '*.txt' 04:09:14 INFO - no previously-included directories found matching 'build' 04:09:14 INFO - no previously-included directories found matching 'dist' 04:09:14 INFO - no previously-included directories found matching '.git*' 04:09:14 INFO - Successfully installed jsonschema functools32 04:09:14 INFO - Cleaning up... 04:09:14 INFO - Return code: 0 04:09:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:14 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')]} 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:14 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')]} 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:14 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 0x7f4958ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', '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 04:09:14 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 04:09:14 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 04:09:14 INFO - Using env: {'DISPLAY': ':0', 04:09:14 INFO - 'HOME': '/home/cltbld', 04:09:14 INFO - 'LANG': 'en_US.UTF-8', 04:09:14 INFO - 'LANGUAGE': 'en_US:en', 04:09:14 INFO - 'LOGNAME': 'cltbld', 04:09:14 INFO - 'MAIL': '/var/mail/cltbld', 04:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:14 INFO - 'MOZ_NO_REMOTE': '1', 04:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:14 INFO - 'NO_EM_RESTART': '1', 04:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:14 INFO - 'PWD': '/builds/slave/test', 04:09:14 INFO - 'SHELL': '/bin/bash', 04:09:14 INFO - 'SHLVL': '1', 04:09:14 INFO - 'TERM': 'linux', 04:09:14 INFO - 'TMOUT': '86400', 04:09:14 INFO - 'USER': 'cltbld', 04:09:14 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:14 INFO - '_': '/tools/buildbot/bin/python'} 04:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:14 INFO - Downloading/unpacking flake8 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:16 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 04:09:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:16 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 04:09:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 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 04:09:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:16 INFO - no previously-included directories found matching 'docs/_build' 04:09:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:16 INFO - Running setup.py install for pep8 04:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:16 INFO - no previously-included directories found matching 'docs/_build' 04:09:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:17 INFO - Cleaning up... 04:09:17 INFO - Return code: 0 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - Running post-action listener: _start_resource_monitoring 04:09:17 INFO - Starting resource monitoring. 04:09:17 INFO - ##### 04:09:17 INFO - ##### Running install step. 04:09:17 INFO - ##### 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: install 04:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:17 INFO - Reading from file tmpfile_stdout 04:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:17 INFO - Reading from file tmpfile_stdout 04:09:17 INFO - Output received: 04:09:17 INFO - Usage: mozinstall [options] installer 04:09:17 INFO - Options: 04:09:17 INFO - -h, --help show this help message and exit 04:09:17 INFO - -d DEST, --destination=DEST 04:09:17 INFO - Directory to install application into. [default: 04:09:17 INFO - "/builds/slave/test"] 04:09:17 INFO - --app=APP Application being installed. [default: firefox] 04:09:17 INFO - mkdir: /builds/slave/test/build/application 04:09:17 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'] 04:09:17 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 04:09:31 INFO - Reading from file tmpfile_stdout 04:09:31 INFO - Output received: 04:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:31 INFO - Running post-action listener: _resource_record_post_action 04:09:31 INFO - ##### 04:09:31 INFO - ##### Running run-tests step. 04:09:31 INFO - ##### 04:09:31 INFO - Running pre-action listener: _resource_record_pre_action 04:09:31 INFO - Running main action method: run_tests 04:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:31 INFO - Python 2.7.3 04:09:31 INFO - Return code: 0 04:09:31 INFO - grabbing minidump binary from tooltool 04:09:31 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')]} 04:09:31 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 0xe2a0b0>, '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 0xe2afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:31 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 04:09:31 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 04:09:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:31 INFO - Return code: 0 04:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:32 INFO - Return code: 0 04:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 04:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 04:09:32 INFO - Using env: {'DISPLAY': ':0', 04:09:32 INFO - 'HOME': '/home/cltbld', 04:09:32 INFO - 'LANG': 'en_US.UTF-8', 04:09:32 INFO - 'LANGUAGE': 'en_US:en', 04:09:32 INFO - 'LOGNAME': 'cltbld', 04:09:32 INFO - 'MAIL': '/var/mail/cltbld', 04:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:32 INFO - 'MOZ_NO_REMOTE': '1', 04:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:32 INFO - 'NO_EM_RESTART': '1', 04:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:32 INFO - 'PWD': '/builds/slave/test', 04:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:32 INFO - 'SHELL': '/bin/bash', 04:09:32 INFO - 'SHLVL': '1', 04:09:32 INFO - 'TERM': 'linux', 04:09:32 INFO - 'TMOUT': '86400', 04:09:32 INFO - 'USER': 'cltbld', 04:09:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628', 04:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:32 INFO - '_': '/tools/buildbot/bin/python'} 04:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 04:09:33 INFO - mozversion INFO | application_buildid: 20151211024841 04:09:33 INFO - mozversion INFO | application_changeset: 754b4805a65cab4f3aca99899227acc44ba4fb20 04:09:33 INFO - mozversion INFO | application_display_name: Nightly 04:09:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:33 INFO - mozversion INFO | application_name: Firefox 04:09:33 INFO - mozversion INFO | application_remotingname: firefox 04:09:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:09:33 INFO - mozversion INFO | application_vendor: Mozilla 04:09:33 INFO - mozversion INFO | application_version: 45.0a1 04:09:33 INFO - mozversion INFO | platform_buildid: 20151211024841 04:09:33 INFO - mozversion INFO | platform_changeset: 754b4805a65cab4f3aca99899227acc44ba4fb20 04:09:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:09:33 INFO - mozversion INFO | platform_version: 45.0a1 04:09:33 INFO - 2015-12-11 04:09:33,102 DEBUG : using testdate: 1449835773 04:09:33 INFO - 2015-12-11 04:09:33,102 DEBUG : actual date: 1449835773 04:09:33 INFO - 2015-12-11 04:09:33,150 INFO : starting webserver on 'localhost:59040' 04:09:33 INFO - 2015-12-11 04:09:33,151 INFO : Starting test suite talos-linux64-ix-001 04:09:33 INFO - 2015-12-11 04:09:33,151 INFO : Starting test dromaeo_css 04:09:33 INFO - 2015-12-11 04:09:33,151 DEBUG : operating with platform_type : linux_ 04:09:33 INFO - 2015-12-11 04:09:33,151 INFO : Initialising browser for dromaeo_css test... 04:09:33 INFO - 2015-12-11 04:09:33,163 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD16mUK/profile http://localhost:59040/getInfo.html 04:09:37 INFO - 2015-12-11 04:09:37,641 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:37 INFO - 2015-12-11 04:09:37,641 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:37 INFO - 2015-12-11 04:09:37,641 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:37 INFO - 2015-12-11 04:09:37,642 DEBUG : BROWSER_OUTPUT: __metrics 04:09:37 INFO - 2015-12-11 04:09:37,750 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] 04:09:37 INFO - 2015-12-11 04:09:37,818 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:39 INFO - 2015-12-11 04:09:39,034 INFO : Browser initialized. 04:09:39 INFO - 2015-12-11 04:09:39,035 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:39 INFO - 2015-12-11 04:09:39,035 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD16mUK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:51 INFO - 2015-12-11 04:09:51,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 142684160 04:09:51 INFO - 2015-12-11 04:09:51,076 DEBUG : BROWSER_OUTPUT: 04:10:42 INFO - 2015-12-11 04:10:42,125 DEBUG : BROWSER_OUTPUT: 1449835842125 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] 04:12:54 INFO - 2015-12-11 04:12:54,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59040/tests/dromaeo/cssquery-ext.html) 04:12:55 INFO - 2015-12-11 04:12:55,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 231886848 04:12:55 INFO - 2015-12-11 04:12:55,100 DEBUG : BROWSER_OUTPUT: 04:15:57 INFO - 2015-12-11 04:15:57,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-ext.html (next: http://localhost:59040/tests/dromaeo/cssquery-jquery.html) 04:15:58 INFO - 2015-12-11 04:15:58,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 218939392 04:15:58 INFO - 2015-12-11 04:15:58,076 DEBUG : BROWSER_OUTPUT: 04:19:00 INFO - 2015-12-11 04:19:00,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59040/tests/dromaeo/cssquery-mootools.html) 04:19:00 INFO - 2015-12-11 04:19:00,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 224182272 04:19:00 INFO - 2015-12-11 04:19:00,737 DEBUG : BROWSER_OUTPUT: 04:22:02 INFO - 2015-12-11 04:22:02,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59040/tests/dromaeo/cssquery-prototype.html) 04:22:03 INFO - 2015-12-11 04:22:03,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 199106560 04:22:03 INFO - 2015-12-11 04:22:03,261 DEBUG : BROWSER_OUTPUT: 04:25:06 INFO - 2015-12-11 04:25:06,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59040/tests/dromaeo/cssquery-yui.html) 04:25:06 INFO - 2015-12-11 04:25:06,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 203522048 04:25:06 INFO - 2015-12-11 04:25:06,675 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/dromaeo/cssquery-yui.html (next: http://localhost:59040/tests/dromaeo/cssquery-dojo.html) 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 251785216 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:09 INFO - 2015-12-11 04:28:09,400 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:09 INFO - 2015-12-11 04:28:09,401 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2601.115620688966;2724.782017438605;2731.890724371025;2746.752792248697;2761.4339060492593;4511.48117966434;4651.767411629417;4675.929861052087;4696.201645720232;4716.457607375153;4513.210188217057;4567.703099298543;4638.397008388904;4642.117997580457;4762.618990480762;4169.62473377396;4285.357196420547;4315.503717072537;4330.891727706817;4437.600615944564;4384.561543845622;4407.735535867842;4440.178566965105;4442.11157768446;4484.573965473275;4108.219438306712;4214.178235244098;4229.323308270693;4313.870583882457;4337.219300525904;4316.870493885189;4323.589259020388;4325.178216138955;4339.696221264513;4365.12697460506;4266.466691663542;4290.420793192941;4298.032942587893;4325.048489332342;4351.630111440531;4400.7579583122915;4478.910421791578;4491.887702807423;4533.546645335473;4639.884002899955;4974.552290293891;5003.224500202475;5004.974975125101;5008.398992120932;5047.9747601262125;5028.673136246132;5030;5031.798728050873;5039.3448851649055;5047.217681259411;4572.0627271409285;4636.304554316879;4687.718736875799;4698.553637404441;4768.61851051915;5224.660397074178;5251.658642188246;5256.894862102737;5260.316158899319;5266.34170728659;5027.120253955543;5038.370203724535;5045.672031317952;5050.84847454577;5094.439611642716;4867.3915760529935;4886.65793394459;4989.451160372356;4995.725235112031;4998.600111991032;5060.291559181717;5063.670861394071;5071.923921141186;5096.23556466533;5107.61692873036;5039.5968322534845;5040.84877453677;5044.974775126101;5047.520485553867;5085.567726743268;4058.8782336529953;4204.2432362175105;4266.146770645822;4269.765162916069;4319.935200971988;3537.646235376442;3608.4226523756074;3632.20091579852;3652.36083685354;3713.053171441265;4336.306191009423;4353.1293741251875;4354.433923589913;4364.60718535327;4397.73613583186;4819.831305904277;4936.975315123402;5092.414372347153;5099.796008159632;5139.717315547681;4210.936835947463;4278.743275403485;4298.097399546068;4306.956930430718;4307.827686892552;4449.510553839075;4492.326151077365;4494.4157259556705;4504.594586487232;4533.637309015271;4755.524447555217;4760.214564596803;4762.761861906891;4766.571008609242;4809.110314591811;4809.038192361611;4900.754962251945;4927.507249275044;4989.775460104232;5077.669951453291;4825.9034819304115;4834.347363106076;4838.612910967185;4841.830535931225;4882.902341953212;5029.572486338702;5051.873703157304;5052.292679025013;5053.343065401475;5054.898902022012;4767.33257343979;4910.8281210157475;4921.064997650435;5127.692338459704;5163.767630456563;4895.069936712013;4983.327250821093;4985.551300382983;4995.050940321327;5021.372328458942;4877.6829506081995;4908.214685650421;4921.655484116078;4930.309756634002;4974.054929563371;4639.721616703008;4755.5719985201495;4757.952420475751;4825.10735513931;4876.146674332049;4869.926951095807;4955.776990035529;4957.776900039435;4980.203167493184;5001.224810154432;4830.7826147822725;4858.92711609319;4863.440704318907;4863.659543831898;4901.828436004723 04:28:09 INFO - 2015-12-11 04:28:09,403 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.7908069399443;561.1918836874902;573.263356586786;590.5452801342966;593.2910172344048;26276.211713648598;36104.27791444169;36109.81945090274;36439.81780091096;36484.817575912115;39997.800010999905;40619.187616247735;40640.79679601598;40673.796631016805;40710;7030.26182250864;7081.787546373617;7862.095858976205;8041.55771432571;8056.39577031722;7086;10127.442990635513;10335.638252661158;10353.223508236875;10356.119729822974;9899.109080182781;9934.155596774282;10003;10010.34932729374;10035.949820250926;7282.563046217244;9860.950695246549;10021.949890250502;10026.448545330004;10036.19710423168;7176.748813791544;9943.303968722192;10320.896791032068;10325.122364599018;10339.79320413595;37525.624743752756;37974.620253797664;37990.62009379926;37994.24011519754;38002.42996355057;2811.4236581500745;2855.486012517746;3321.4353559894876;3565.3047655707146;3614.078410005458;28220.294492637644;28293.15120546387;28701.712982870322;28815.711842881512;29475.115746527637;3172.3338098999006;3252.4308246056844;3262.151840521458;3314.3371325734947;3349.949750753741;210545;211010.88989110067;211034;211128;211131;54914.725426373414;55260;55287.44712552823;55299.723501382236;55342.72328638411;59291.70354148201;59450.40549594535;59477.97047398546;59533;59537.40462595318;12321.383930803424;12679.175853569674;12686.873131268754;12695.55565555201;12705.745885082246;9986.700398988041;10028.047335503115;10050.396976181453;10051.547680354402;10056.245781566266;18750.24999000052;18777.530561736065;18814.717779233324;18855.43433696964;18901;7266;7481.177070522238;7555.16893141754;7605.353544948631;7656.196099409593;792.6868886789802;799.7720649614832;916.225789208118;957.989321266057;1037.1650821088945;26187.869060654575;26470.882329413602;26846;26908.192754217405;26953.191404257905;809.1423091523004;826.557791581513;931.65063101337;937.6905621145143;956.3496822160997;11729.589464368877;12125.757484850254;12532.749345013048;12611.621651350475;13138.934305328412;245607;252015;252289;252528;252612;45053;45295.77352113284;45334;45372.77313613411;45375.773121134844;1070.3203465799274;1121.472907733364;1126.5437497813398;1227.8096894981293;1230.2802860326808;23460.64809027832;23869.761302387447;26341.34146646349;26527.204183874514;26604.733952661;36164.45753313755;36521.52177173445;36531.81734091313;36556.81721591375;36616.63383366239;174544;175620;175627.12186438986;175768;175993;26669.59995600029;26697;27029;27058.72941270562;27171.456570868868;36582;36805.815970919975;37298;37404;37542.624573753914;31704.841475792473;31784.523232151998;31875.52186717155;32062.358752824348;32221.838890805397;31717;31968.52047219247;34545.81812728111;35960;36423;32017.67982320147;37587;37729.81135094417;37774.24451510899;40614.39078413885;32162.678373216906;33031.66968330382;33417;34109.65890341164;36580.26839463143;27665.861670691516;28519.572206417335;28675.56986645244;28861.56707649345;28931 04:28:09 INFO - 2015-12-11 04:28:09,404 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.9395308844408;336.48685754224806;338.50578155892396;340.3227577121529;340.45357201691286;12588.055895807805;12920.54778082765;14741.189234592093;14994.997685496277;16546.255418506167;12859.742805143891;15079.849201507981;15330.233488325595;15637.687246255096;15670.529884103495;4660.091282199973;4664.740520059599;4671.719696818185;4856.125897338477;4860.441049279334;3764.1530655602546;3865.1496670732395;5057.2666963290485;5640.830775076754;5829.912551311712;5726.255586773714;5726.828195154152;5748;5766.855828604297;5770.33641131269;5696.259486266779;5904.616199947011;5906.37983011784;5921.822345329604;5931.822045338647;5180.3265575475325;5180.378354597435;5182.455842136559;5196.272521846944;5198.818041368571;18416.53958651031;18766.155523001496;18833.905830470896;19159.329423470113;19662.80337196624;1758.9208485618178;1808.1411329618456;1862.0503543192933;1940.631854542544;1974.3978086683555;8357.289630381425;8559.657613695445;8608.31133509324;8791.736247912573;8832.293416526727;1677.447648284171;1709.265016043101;1725.843684731233;1729.5416714570524;1771.2118107442193;54205.1869221962;55257.723711381586;56185.43814561843;56263;57271.71364143194;9622.807543849083;9635.373700709431;9637.132658060807;9725.513724313898;9829.754256143653;12410.193337433038;12415.317157556241;12430.689232769073;12434.129610927148;12441.564545240873;6565;6657.400833924873;6756.223034351015;6783.38949494538;6808.114945057111;6509.251436084816;6586.901196482057;6612.702428390734;6655.0682904393425;6685.799426017227;4009.498812648419;4045.716799824043;4134.958650413458;4181.91636167281;4210.073783767566;1619.1094897806395;1656.8011838579207;1661.3188592676945;1666.858317043065;1692.2638652186338;744.4751450227576;803.5660743198607;883.5273128876021;892.9866052009226;972.837459236206;14638.926805366118;15079.262535407115;15305.387784488496;15553.30010149546;16094.275757590936;702.3994484715597;807.7657479330928;816.77946954322;843.5487014447364;859.0679113162289;8325.8334833303;8946.329025323126;9079.364444488823;9386.249100071978;9618.807623847484;489119;493213;493434;500969;512707;72052.63973680203;74275.25724742791;75803.62098189474;75860.62069689616;76134;1016.8779746430475;1042.296449896317;1049.1082579807103;1051.24835742443;1053.4890578069783;14073.366698498387;14387.712245755236;14481.47944465816;14738.63153421173;15202.087874727551;34853.65146348504;34900.47649285314;35192.22897760797;35275.82362088173;35366.46950295799;39248.21503569856;39355;39483.802580988064;40658;40982.38526422166;8363.916360836314;8382.874256886029;8445.746627601182;8590.1839325264;8795.692150774692;10100.646477373257;13277.40251688657;14934.626634334229;15055.473058442902;16036.438724645048;12681.048921330752;12977.870221297666;13167.60497185086;13603.727925441237;13769.105008174436;2248.2018883296196;9502.85745713801;13035.914253719739;13053.303467004946;13252.734945301232;10684.83972740394;13988.860111398755;14232.857671423568;14393.64015899569;14400;7432.554046757212;7513.2862378074;7519.736809211651;8559.786005349915;8740.125987401208;12189.51241950312;12527.310997895203;12688.74622507563;12696.809547856974;12922.870771292166 04:28:09 INFO - 2015-12-11 04:28:09,408 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1233.9074569407296;1644.572411173095;1666.1336105225282;1682.9410970616032;1715.7340612205105;5890.793822216223;6715.66421678916;6859.794206173817;6881.449484041277;6898.724051037952;6722.193336799579;6863.691133898974;6914.8271293217695;6916.58500489971;6937.653117344138;2010.6581881080251;2054.938351849447;2056.9382918512392;2058.660321047033;2060.701198326242;2090.6759452284846;2126.680997850327;2133.797289257518;2142.7857214278524;2146.892655367233;2093.8534302598746;2100.01797447624;2113.8837363944976;2136.380449669594;2137.465633591602;2033.3290014295394;2033.7762846086919;2065.1120018392085;2066.2664754012335;2067.214458505766;2027.9594408111902;2059.742532183477;2065.173930427826;2066.4627196928755;2077.9480512987298;6905.585664860125;7000.719971201146;7011.544249623758;7016;7039.120109986252;4152;4207.221663992141;4215.3887686285625;4217.704760666755;4232.132412855388;2635.9868200659066;2648.3511539672904;2667.7065522792477;2694.0436145168574;2705.5400581900926;816.5835423933777;819.737683941139;828.6022709099666;840.6759354017386;849.4818160921833;9422.905770942272;9428.575714092814;9436.245100391952;9437.480938548377;9443.952780236055;3932.3511620582285;3937.8031098444962;3991.640752332246;3994.960050399517;4019.8392064317686;8085.393595480363;8127.146649601825;8127.431079824474;8151.388645851466;8159.632816523271;4249.065205654751;4262.46719160105;4281.165172791338;4285.485741710952;4291.399204111427;3267.8856240031487;3357.1774915145947;3775.207206486614;3872.9612703873163;3880.262750077476;3311.8344082795766;3316.286998295378;3337.4826901830256;3337.6829201225846;3351.631320554737;1049.800537897797;1064.3826580583243;1065.515190588296;1065.6696424108552;1073.3184427888348;822.0915887943855;860.9784755381165;1143.5540139345662;1186.3534373766317;1191.559123124432;6120.234970628671;6141.263048434216;6146.477549408351;6159.722812473449;6168.444839964424;1037.5019990404649;1049.6955882794057;1055.7413433708791;1060.3743791163251;1065.3680836790913;5321.3348331458565;5354.732263386815;5361;5362.142057270896;5367.919481207785;8211.794705132419;8311.127331630212;8528.104549022388;8528.232459078712;8532.658693652184;8317.542535160625;8351.039630442456;8431.873521897176;8446.957765211257;8473.95763021181;6076.149339092531;6333.68331583419;6609.438197753245;6668.166479190101;6675.299093595199;6704.363085506869;6853.554518956252;6860.176778786577;6868.690908909211;6868.862622747617;7386.889196661947;7573.242675732383;7593.696252149852;7654.617269136632;7660.463767536442;7670.961645191738;7822.882656760039;7885.44801863864;7895.131535531202;7982.560959147303;5647.576431767716;5771.7402716877;6578.309277525982;6617.205935287796;6661.267260601233;6331.3352098029045;6334.493240540838;6350.936490635219;6450.548461607643;6508.511861610304;6052.2132122825515;6297.590656607306;6322.209723784527;6345.079963405188;6447.6131432114225;6027.397260273938;6066.575339726177;6102.267727872683;6104.145419641165;6320.115183874169;6157.568970172045;6165.445109940127;6179.196704428396;6200.100985357008;6210.596311239755;5756.597038207286;5796.42035796417;5808.73860676279;5818;5820.534357251325;5697.715114244188;5746.310442746897;5782.3639399666845;5858.1558172191935;5861.238039054895 04:28:09 INFO - 2015-12-11 04:28:09,409 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.895501052137;306.9585605943197;308.39246684032463;311.90486901495046;314.7198992896322;5309.123994540901;5397.784088636455;5481.671099734019;5521.089020311644;5532.502074813266;5338.145896656536;5380.354357477098;5410;5410.377806552247;5434.510894019538;3922.1567363016948;4019.055521952339;4159.417681524581;4160.147169830193;4168.520620128694;4059.0867054912705;4143.523494798092;4160.105577300879;4161.188568229197;4165.250254954107;4096.97951510242;4099.61053699898;4107.28122578549;4111.177764447108;4111.48606424197;3895.1625400538737;3987.6610488108545;4009.3184158693093;4089.161721847014;4106.384042393635;3563.55455568054;3573.5175751273505;3576.5708115026105;3584.62361452049;3591.425371940477;5078.542931136216;5085.5931525478245;5091.981603679279;5096.79612815487;5100.5919526438165;4728.38530990969;4738.644601654855;4740.834070807539;4746.098241334135;4751.239801631722;5466.234727138204;5650.29371328584;5657.547396208334;5659.60382773206;5670.914936275959;3898.3372826619543;3918.941215881764;3919.314120029012;3923.8234279457492;3925.568187499373;5904.143899134644;5987.461128498412;5992.2809262888295;5996.400359964013;6003.739214764904;4038.757674539537;4043.7169398142437;4046.089629833264;4048.2713111640187;4055.1078762672164;3792.924141517154;3868.323043467382;4076.0421300994244;4102.610252026053;4105.67154627629;4634.096351211549;4723.716577005391;4733.242681170997;4742.881427964328;4743.928841067387;5684.8294551163535;5686.061799802987;5689.630174038757;5706.80026199081;5707.6575405475805;1436.2531483628454;1453.7601295786076;1455.3305479479345;1455.9344829482698;1456.410153887677;966.7728083900278;968.0271327316002;975.1954637424153;989.1690979577046;989.3964681544252;4977.800887964513;4977.950220497821;4983.103041452501;4983.327250821093;4987.326710894055;5921.881562368729;5922.052471604608;5930.080837470113;5931.73307201177;5934.851628709317;4976.2286845539;4978.153713868579;4980.950190498121;4981.2030075187795;4982.800687972513;3069.6469905960653;3152.590163278759;3172.1118086935694;3187.729043031322;3194.6645602211897;5500.147477141049;5511.118221084607;5528.391876893538;5538.556915446755;5542.140968149863;6064.483239455665;6070.969645151746;6078.483328917003;6078.601921558066;6079.939200607937;5403.7838486460105;5518.2826232589505;5521.503064724194;5528.087865502228;5535.501804837584;5882.323532793784;5895.882082358415;5896.941030589639;5902.1736956826935;5910.172575839472;5746.109353050284;5750.6485975796495;5751.252337196138;5753.050746626927;5764.6829424380385;5537.197106419466;5540.944590554204;5541.168824676331;5546.750396232099;5550.861228469321;4038.6163314485075;4052.250333688277;4056.5537790842395;4150.086980864205;4168.103857670615;5656.179853921076;5740.770369185186;5807.680577568274;5859.648421094748;5903.203067585821;5499.1476321170285;5662.66024038559;5665.631733937281;5667.4615911488345;5675.545956323567;5711.257536520392;5713.9428605715075;5723.771049157987;5724.513416359656;5726.341470730919;5403.13549832025;5594.328680558359;5595.972020140036;5598.720063996865;5602.299712535933;5707.800226992202;5739.71301434935;5747.770089196385;5785.218995435563;5798.10129429939;5642.069058605284;5650.660960342392;5662.915056274077;5663.4053424391495;5665.235193248858 04:28:09 INFO - 2015-12-11 04:28:09,412 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.3574168797953;716.0226291112633;749.673891857042;751.6692655231698;760.1068744225535;10765;11019.614313499029;11020.283681560693;11026.779464410716;11027.944860275697;11078.501467433965;11226.831597526043;11237.101031917447;11329.037031852282;11340;623.5261201486858;630;794.5034353529045;796.358931060496;807.7374853172713;805.1103530598663;811.9391045671598;812;812.6018251056969;816.3265306122443;848.0247715127591;849.4818160921864;849.6771226933756;849.995750021249;850.3962186847315;649.0653459019021;655.3217419970308;833.6207025803275;846.2426128614856;847.6100993542977;629.6725702634604;630.0203184048802;630.486153784664;630.7729217481703;631.2582715309493;10777.622783202629;11005.394703291317;11114.722131946684;11161.107111431065;11184.552617895275;10224.233182511342;10422.9478852606;10732.302400343953;11181.832272515838;11388.658340249805;8664.523451210182;8700.477971321741;9169.908300917039;9192.540372981324;9854.113129818279;3241.286916878283;3272.5091236314743;3291.308825146722;3303.289792694582;3310.519974603693;41075.794621027;41734.79132604348;41926.371104433456;42333.15333693309;42446.57553424457;9278.11857873501;9368.156865881967;9425.104615061558;9442.339036267533;9459.621615135455;16050.518484445485;16066.518004459886;16096.195190240442;16097.517074487783;16101.436449724204;6193.4425901669065;6245.781397651152;6313.355595139439;6504.804855854332;6515.51133664977;3266.1508007917637;3338.966610333914;3558.5373901392654;3608.566971963381;3609.8375573099274;2577.76800087993;2596.805239607037;2614.045873256248;2616.149751330825;2617.646617706623;445.243086752522;456.752776340406;456.9977150114228;460.9101225261042;501.22810871257855;493.8000109955402;516.8837011672343;543.1825103219629;553.3912696034411;565.7793460550389;7474.663640136098;7666.3866890648615;7703.34521565662;7853.293203611703;8004.319632831274;410.704292909105;447.8589244388007;504.6921377959442;528.9365276166884;539.5872157799287;3394.8390884080713;3503.562054743157;3581.2093953023486;3645.8177091145335;3667.284879448482;50979.23531147036;51129.60879890014;51265.7436712814;51441.742791285804;51873.740631297354;45867.77066114648;45873;46117.76941115273;46231.76884115558;46791;41140.38289425661;41319.38020929688;41391;42234;42360.78819605882;7168.24733403006;7246.239144889711;8034.709146517713;8058.153893841062;8346.791330216793;28812.711872881002;29337;29379.265518361357;29548.704512954595;29930.700692992792;38116.42825357677;39804.20391592094;40504.392434112924;41141;41146.794266028475;9822.75443113928;9940.403575785476;10021.649242276486;10066.295359324777;10146.644867429604;10440.477976101316;10475.94762026185;11348.54605815758;11554.306741595195;11602.825957610474;10177.796444071226;10225.488725563544;10569.312994655324;10999.670009899715;11153.275037122885;10228.744281392726;10385.896141038493;10438;10700.571977120828;10995.34027958325;9748.171405430334;9810.901890980998;10074.8488772667;10200.59197632116;10461.9476902615;9433.24534037289;9655;9686.56410461545;9806.264530160124;9844.3601165924;9270.397424167408;9609.471479068718;9640.517974101407;9653.517324133905;9663.710088697351 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,829 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: __startTimestamp1449836889399__endTimestamp 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:09 INFO - 2015-12-11 04:28:09,413 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4645.22 Median:4768.62 stddev:494.33 (10.4%) stddev-sans-first:469.12 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: Values: 2601.1 2724.8 2731.9 2746.8 2761.4 4511.5 4651.8 4675.9 4696.2 4716.5 4513.2 4567.7 4638.4 4642.1 4762.6 4169.6 4285.4 4315.5 4330.9 4437.6 4384.6 4407.7 4440.2 4442.1 4484.6 4108.2 4214.2 4229.3 4313.9 4337.2 4316.9 4323.6 4325.2 4339.7 4365.1 4266.5 4290.4 4298.0 4325.0 4351.6 4400.8 4478.9 4491.9 4533.5 4639.9 4974.6 5003.2 5005.0 5008.4 5048.0 5028.7 5030.0 5031.8 5039.3 5047.2 4572.1 4636.3 4687.7 4698.6 4768.6 5224.7 5251.7 5256.9 5260.3 5266.3 5027.1 5038.4 5045.7 5050.8 5094.4 4867.4 4886.7 4989.5 4995.7 4998.6 5060.3 5063.7 5071.9 5096.2 5107.6 5039.6 5040.8 5045.0 5047.5 5085.6 4058.9 4204.2 4266.1 4269.8 4319.9 3537.6 3608.4 3632.2 3652.4 3713.1 4336.3 4353.1 4354.4 4364.6 4397.7 4819.8 4937.0 5092.4 5099.8 5139.7 4210.9 4278.7 4298.1 4307.0 4307.8 4449.5 4492.3 4494.4 4504.6 4533.6 4755.5 4760.2 4762.8 4766.6 4809.1 4809.0 4900.8 4927.5 4989.8 5077.7 4825.9 4834.3 4838.6 4841.8 4882.9 5029.6 5051.9 5052.3 5053.3 5054.9 4767.3 4910.8 4921.1 5127.7 5163.8 4895.1 4983.3 4985.6 4995.1 5021.4 4877.7 4908.2 4921.7 4930.3 4974.1 4639.7 4755.6 4758.0 4825.1 4876.1 4869.9 4955.8 4957.8 4980.2 5001.2 4830.8 4858.9 4863.4 4863.7 4901.8 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38187.89 Median:17737.13 stddev:55725.86 (314.2%) stddev-sans-first:55810.49 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: Values: 541.8 561.2 573.3 590.5 593.3 26276.2 36104.3 36109.8 36439.8 36484.8 39997.8 40619.2 40640.8 40673.8 40710.0 7030.3 7081.8 7862.1 8041.6 8056.4 7086.0 10127.4 10335.6 10353.2 10356.1 9899.1 9934.2 10003.0 10010.3 10035.9 7282.6 9861.0 10021.9 10026.4 10036.2 7176.7 9943.3 10320.9 10325.1 10339.8 37525.6 37974.6 37990.6 37994.2 38002.4 2811.4 2855.5 3321.4 3565.3 3614.1 28220.3 28293.2 28701.7 28815.7 29475.1 3172.3 3252.4 3262.2 3314.3 3349.9 210545.0 211010.9 211034.0 211128.0 211131.0 54914.7 55260.0 55287.4 55299.7 55342.7 59291.7 59450.4 59478.0 59533.0 59537.4 12321.4 12679.2 12686.9 12695.6 12705.7 9986.7 10028.0 10050.4 10051.5 10056.2 18750.2 18777.5 18814.7 18855.4 18901.0 7266.0 7481.2 7555.2 7605.4 7656.2 792.7 799.8 916.2 958.0 1037.2 26187.9 26470.9 26846.0 26908.2 26953.2 809.1 826.6 931.7 937.7 956.3 11729.6 12125.8 12532.7 12611.6 13138.9 245607.0 252015.0 252289.0 252528.0 252612.0 45053.0 45295.8 45334.0 45372.8 45375.8 1070.3 1121.5 1126.5 1227.8 1230.3 23460.6 23869.8 26341.3 26527.2 26604.7 36164.5 36521.5 36531.8 36556.8 36616.6 174544.0 175620.0 175627.1 175768.0 175993.0 26669.6 26697.0 27029.0 27058.7 27171.5 36582.0 36805.8 37298.0 37404.0 37542.6 31704.8 31784.5 31875.5 32062.4 32221.8 31717.0 31968.5 34545.8 35960.0 36423.0 32017.7 37587.0 37729.8 37774.2 40614.4 32162.7 33031.7 33417.0 34109.7 36580.3 27665.9 28519.6 28675.6 28861.6 28931.0 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,414 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26490.44 Median:22351.86 stddev:81386.03 (364.1%) stddev-sans-first:81590.64 04:28:09 INFO - 2015-12-11 04:28:09,415 DEBUG : BROWSER_OUTPUT: Values: 335.9 336.5 338.5 340.3 340.5 12588.1 12920.5 14741.2 14995.0 16546.3 12859.7 15079.8 15330.2 15637.7 15670.5 4660.1 4664.7 4671.7 4856.1 4860.4 3764.2 3865.1 5057.3 5640.8 5829.9 5726.3 5726.8 5748.0 5766.9 5770.3 5696.3 5904.6 5906.4 5921.8 5931.8 5180.3 5180.4 5182.5 5196.3 5198.8 18416.5 18766.2 18833.9 19159.3 19662.8 1758.9 1808.1 1862.1 1940.6 1974.4 8357.3 8559.7 8608.3 8791.7 8832.3 1677.4 1709.3 1725.8 1729.5 1771.2 54205.2 55257.7 56185.4 56263.0 57271.7 9622.8 9635.4 9637.1 9725.5 9829.8 12410.2 12415.3 12430.7 12434.1 12441.6 6565.0 6657.4 6756.2 6783.4 6808.1 6509.3 6586.9 6612.7 6655.1 6685.8 4009.5 4045.7 4135.0 4181.9 4210.1 1619.1 1656.8 1661.3 1666.9 1692.3 744.5 803.6 883.5 893.0 972.8 14638.9 15079.3 15305.4 15553.3 16094.3 702.4 807.8 816.8 843.5 859.1 8325.8 8946.3 9079.4 9386.2 9618.8 489119.0 493213.0 493434.0 500969.0 512707.0 72052.6 74275.3 75803.6 75860.6 76134.0 1016.9 1042.3 1049.1 1051.2 1053.5 14073.4 14387.7 14481.5 14738.6 15202.1 34853.7 34900.5 35192.2 35275.8 35366.5 39248.2 39355.0 39483.8 40658.0 40982.4 8363.9 8382.9 8445.7 8590.2 8795.7 10100.6 13277.4 14934.6 15055.5 16036.4 12681.0 12977.9 13167.6 13603.7 13769.1 2248.2 9502.9 13035.9 13053.3 13252.7 10684.8 13988.9 14232.9 14393.6 14400.0 7432.6 7513.3 7519.7 8559.8 8740.1 12189.5 12527.3 12688.7 12696.8 12922.9 04:28:09 INFO - 2015-12-11 04:28:09,415 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,415 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4890.11 Median:5959.10 stddev:2505.04 (42.0%) stddev-sans-first:2496.99 04:28:09 INFO - 2015-12-11 04:28:09,416 DEBUG : BROWSER_OUTPUT: Values: 1233.9 1644.6 1666.1 1682.9 1715.7 5890.8 6715.7 6859.8 6881.4 6898.7 6722.2 6863.7 6914.8 6916.6 6937.7 2010.7 2054.9 2056.9 2058.7 2060.7 2090.7 2126.7 2133.8 2142.8 2146.9 2093.9 2100.0 2113.9 2136.4 2137.5 2033.3 2033.8 2065.1 2066.3 2067.2 2028.0 2059.7 2065.2 2066.5 2077.9 6905.6 7000.7 7011.5 7016.0 7039.1 4152.0 4207.2 4215.4 4217.7 4232.1 2636.0 2648.4 2667.7 2694.0 2705.5 816.6 819.7 828.6 840.7 849.5 9422.9 9428.6 9436.2 9437.5 9444.0 3932.4 3937.8 3991.6 3995.0 4019.8 8085.4 8127.1 8127.4 8151.4 8159.6 4249.1 4262.5 4281.2 4285.5 4291.4 3267.9 3357.2 3775.2 3873.0 3880.3 3311.8 3316.3 3337.5 3337.7 3351.6 1049.8 1064.4 1065.5 1065.7 1073.3 822.1 861.0 1143.6 1186.4 1191.6 6120.2 6141.3 6146.5 6159.7 6168.4 1037.5 1049.7 1055.7 1060.4 1065.4 5321.3 5354.7 5361.0 5362.1 5367.9 8211.8 8311.1 8528.1 8528.2 8532.7 8317.5 8351.0 8431.9 8447.0 8474.0 6076.1 6333.7 6609.4 6668.2 6675.3 6704.4 6853.6 6860.2 6868.7 6868.9 7386.9 7573.2 7593.7 7654.6 7660.5 7671.0 7822.9 7885.4 7895.1 7982.6 5647.6 5771.7 6578.3 6617.2 6661.3 6331.3 6334.5 6350.9 6450.5 6508.5 6052.2 6297.6 6322.2 6345.1 6447.6 6027.4 6066.6 6102.3 6104.1 6320.1 6157.6 6165.4 6179.2 6200.1 6210.6 5756.6 5796.4 5808.7 5818.0 5820.5 5697.7 5746.3 5782.4 5858.2 5861.2 04:28:09 INFO - 2015-12-11 04:28:09,416 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,416 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4690.28 Median:5406.89 stddev:1393.42 (25.8%) stddev-sans-first:1357.86 04:28:09 INFO - 2015-12-11 04:28:09,416 DEBUG : BROWSER_OUTPUT: Values: 302.9 307.0 308.4 311.9 314.7 5309.1 5397.8 5481.7 5521.1 5532.5 5338.1 5380.4 5410.0 5410.4 5434.5 3922.2 4019.1 4159.4 4160.1 4168.5 4059.1 4143.5 4160.1 4161.2 4165.3 4097.0 4099.6 4107.3 4111.2 4111.5 3895.2 3987.7 4009.3 4089.2 4106.4 3563.6 3573.5 3576.6 3584.6 3591.4 5078.5 5085.6 5092.0 5096.8 5100.6 4728.4 4738.6 4740.8 4746.1 4751.2 5466.2 5650.3 5657.5 5659.6 5670.9 3898.3 3918.9 3919.3 3923.8 3925.6 5904.1 5987.5 5992.3 5996.4 6003.7 4038.8 4043.7 4046.1 4048.3 4055.1 3792.9 3868.3 4076.0 4102.6 4105.7 4634.1 4723.7 4733.2 4742.9 4743.9 5684.8 5686.1 5689.6 5706.8 5707.7 1436.3 1453.8 1455.3 1455.9 1456.4 966.8 968.0 975.2 989.2 989.4 4977.8 4978.0 4983.1 4983.3 4987.3 5921.9 5922.1 5930.1 5931.7 5934.9 4976.2 4978.2 4981.0 4981.2 4982.8 3069.6 3152.6 3172.1 3187.7 3194.7 5500.1 5511.1 5528.4 5538.6 5542.1 6064.5 6071.0 6078.5 6078.6 6079.9 5403.8 5518.3 5521.5 5528.1 5535.5 5882.3 5895.9 5896.9 5902.2 5910.2 5746.1 5750.6 5751.3 5753.1 5764.7 5537.2 5540.9 5541.2 5546.8 5550.9 4038.6 4052.3 4056.6 4150.1 4168.1 5656.2 5740.8 5807.7 5859.6 5903.2 5499.1 5662.7 5665.6 5667.5 5675.5 5711.3 5713.9 5723.8 5724.5 5726.3 5403.1 5594.3 5596.0 5598.7 5602.3 5707.8 5739.7 5747.8 5785.2 5798.1 5642.1 5650.7 5662.9 5663.4 5665.2 04:28:09 INFO - 2015-12-11 04:28:09,416 DEBUG : BROWSER_OUTPUT: 04:28:09 INFO - 2015-12-11 04:28:09,417 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12268.33 Median:23162.38 stddev:14160.55 (61.1%) stddev-sans-first:14173.49 04:28:09 INFO - 2015-12-11 04:28:09,417 DEBUG : BROWSER_OUTPUT: Values: 669.4 716.0 749.7 751.7 760.1 10765.0 11019.6 11020.3 11026.8 11027.9 11078.5 11226.8 11237.1 11329.0 11340.0 623.5 630.0 794.5 796.4 807.7 805.1 811.9 812.0 812.6 816.3 848.0 849.5 849.7 850.0 850.4 649.1 655.3 833.6 846.2 847.6 629.7 630.0 630.5 630.8 631.3 10777.6 11005.4 11114.7 11161.1 11184.6 10224.2 10422.9 10732.3 11181.8 11388.7 8664.5 8700.5 9169.9 9192.5 9854.1 3241.3 3272.5 3291.3 3303.3 3310.5 41075.8 41734.8 41926.4 42333.2 42446.6 9278.1 9368.2 9425.1 9442.3 9459.6 16050.5 16066.5 16096.2 16097.5 16101.4 6193.4 6245.8 6313.4 6504.8 6515.5 3266.2 3339.0 3558.5 3608.6 3609.8 2577.8 2596.8 2614.0 2616.1 2617.6 445.2 456.8 457.0 460.9 501.2 493.8 516.9 543.2 553.4 565.8 7474.7 7666.4 7703.3 7853.3 8004.3 410.7 447.9 504.7 528.9 539.6 3394.8 3503.6 3581.2 3645.8 3667.3 50979.2 51129.6 51265.7 51441.7 51873.7 45867.8 45873.0 46117.8 46231.8 46791.0 41140.4 41319.4 41391.0 42234.0 42360.8 7168.2 7246.2 8034.7 8058.2 8346.8 28812.7 29337.0 29379.3 29548.7 29930.7 38116.4 39804.2 40504.4 41141.0 41146.8 9822.8 9940.4 10021.6 10066.3 10146.6 10440.5 10475.9 11348.5 11554.3 11602.8 10177.8 10225.5 10569.3 10999.7 11153.3 10228.7 10385.9 10438.0 10700.6 10995.3 9748.2 9810.9 10074.8 10200.6 10461.9 9433.2 9655.0 9686.6 9806.3 9844.4 9270.4 9609.5 9640.5 9653.5 9663.7 04:28:09 INFO - 2015-12-11 04:28:09,417 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:09 INFO - 2015-12-11 04:28:09,417 DEBUG : BROWSER_OUTPUT: 04:28:10 INFO - 2015-12-11 04:28:10,144 INFO : Browser exited with error code: 0 04:28:10 INFO - 2015-12-11 04:28:10,163 INFO : Completed test dromaeo_css (00:18:37) 04:28:10 INFO - 2015-12-11 04:28:10,163 INFO : Starting test kraken 04:28:10 INFO - 2015-12-11 04:28:10,163 DEBUG : operating with platform_type : linux_ 04:28:10 INFO - 2015-12-11 04:28:10,163 INFO : Initialising browser for kraken test... 04:28:10 INFO - 2015-12-11 04:28:10,169 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4LaAU/profile http://localhost:59040/getInfo.html 04:28:14 INFO - 2015-12-11 04:28:14,823 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:14 INFO - 2015-12-11 04:28:14,823 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:14 INFO - 2015-12-11 04:28:14,823 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:14 INFO - 2015-12-11 04:28:14,823 DEBUG : BROWSER_OUTPUT: __metrics 04:28:14 INFO - 2015-12-11 04:28:14,884 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] 04:28:14 INFO - 2015-12-11 04:28:14,960 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:14 ERROR - 2015-12-11 04:28:14,968 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:28:15 INFO - 2015-12-11 04:28:15,990 INFO : Browser initialized. 04:28:15 INFO - 2015-12-11 04:28:15,990 INFO : Running cycle 1/1 for kraken test... 04:28:15 INFO - 2015-12-11 04:28:15,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4LaAU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:27 INFO - 2015-12-11 04:28:27,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 142741504 04:28:27 INFO - 2015-12-11 04:28:27,972 DEBUG : BROWSER_OUTPUT: 04:28:30 INFO - 2015-12-11 04:28:30,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59040/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:31 INFO - 2015-12-11 04:28:31,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 179146752 04:28:31 INFO - 2015-12-11 04:28:31,194 DEBUG : BROWSER_OUTPUT: 04:28:33 INFO - 2015-12-11 04:28:33,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59040/tests/kraken/driver.html?testName=audio-dft) 04:28:34 INFO - 2015-12-11 04:28:34,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 167903232 04:28:34 INFO - 2015-12-11 04:28:34,557 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2015-12-11 04:28:37,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59040/tests/kraken/driver.html?testName=audio-fft) 04:28:38 INFO - 2015-12-11 04:28:38,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 154271744 04:28:38 INFO - 2015-12-11 04:28:38,113 DEBUG : BROWSER_OUTPUT: 04:28:40 INFO - 2015-12-11 04:28:40,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59040/tests/kraken/driver.html?testName=audio-oscillator) 04:28:40 INFO - 2015-12-11 04:28:40,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 154509312 04:28:40 INFO - 2015-12-11 04:28:40,771 DEBUG : BROWSER_OUTPUT: 04:28:43 INFO - 2015-12-11 04:28:43,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59040/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:43 INFO - 2015-12-11 04:28:43,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 156483584 04:28:43 INFO - 2015-12-11 04:28:43,612 DEBUG : BROWSER_OUTPUT: 04:28:46 INFO - 2015-12-11 04:28:46,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59040/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:47 INFO - 2015-12-11 04:28:47,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 156499968 04:28:47 INFO - 2015-12-11 04:28:47,200 DEBUG : BROWSER_OUTPUT: 04:28:50 INFO - 2015-12-11 04:28:50,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59040/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:51 INFO - 2015-12-11 04:28:51,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 158818304 04:28:51 INFO - 2015-12-11 04:28:51,243 DEBUG : BROWSER_OUTPUT: 04:28:54 INFO - 2015-12-11 04:28:54,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59040/tests/kraken/driver.html?testName=json-parse-financial) 04:28:54 INFO - 2015-12-11 04:28:54,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 156893184 04:28:54 INFO - 2015-12-11 04:28:54,648 DEBUG : BROWSER_OUTPUT: 04:28:56 INFO - 2015-12-11 04:28:56,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59040/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:57 INFO - 2015-12-11 04:28:56,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 165490688 04:28:57 INFO - 2015-12-11 04:28:57,000 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2015-12-11 04:28:58,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:59 INFO - 2015-12-11 04:28:59,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 166666240 04:28:59 INFO - 2015-12-11 04:28:59,476 DEBUG : BROWSER_OUTPUT: 04:29:01 INFO - 2015-12-11 04:29:01,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:02 INFO - 2015-12-11 04:29:02,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 176144384 04:29:02 INFO - 2015-12-11 04:29:02,222 DEBUG : BROWSER_OUTPUT: 04:29:04 INFO - 2015-12-11 04:29:04,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:05 INFO - 2015-12-11 04:29:05,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 182120448 04:29:05 INFO - 2015-12-11 04:29:05,326 DEBUG : BROWSER_OUTPUT: 04:29:08 INFO - 2015-12-11 04:29:08,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:08 INFO - 2015-12-11 04:29:08,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 178171904 04:29:08 INFO - 2015-12-11 04:29:08,582 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59040/tests/kraken/driver.html?testName=ai-astar) 04:29:10 INFO - 2015-12-11 04:29:10,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 237797376 04:29:10 INFO - 2015-12-11 04:29:10,638 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,642 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:10 INFO - 2015-12-11 04:29:10,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:10 INFO - 2015-12-11 04:29:10,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:10 INFO - 2015-12-11 04:29:10,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:10 INFO - 2015-12-11 04:29:10,642 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;111;114;114;101;111;111;111 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;132;157;184;139;157;161;136;164;132 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;161;160;160;160;161;159 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;90;97;72;72;73;101;99;72 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;141;94;94;94;130;95;95;128 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;110;109;109;109 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;146;147;146;146;146;146;147 04:29:10 INFO - 2015-12-11 04:29:10,643 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;96;96;95 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;73;72;73;72;71;79;70;70 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;67;69;69;69;68;68;68;68 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;93;83;84;84;84;85;86;83 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;125;124;121;130;129;124;127;128;120 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;140;151;165;155;152;151;158;157;140 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;72;73;71;71;71;70;73;73 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:10 INFO - 2015-12-11 04:29:10,644 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:29:10 INFO - 2015-12-11 04:29:10,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1015 04:29:10 INFO - 2015-12-11 04:29:10,645 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:29:10 INFO - 2015-12-11 04:29:10,645 DEBUG : BROWSER_OUTPUT: __startTimestamp1449836950640__endTimestamp 04:29:10 INFO - 2015-12-11 04:29:10,645 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.09 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 111.0 114.0 114.0 101.0 111.0 111.0 111.0 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.30 Median:157.00 stddev:16.73 (10.7%) stddev-sans-first:17.75 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: Values: 151.0 132.0 157.0 184.0 139.0 157.0 161.0 136.0 164.0 132.0 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 161.0 159.0 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,649 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:73.00 stddev:13.00 (17.8%) stddev-sans-first:13.17 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 90.0 97.0 72.0 72.0 73.0 101.0 99.0 72.0 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:18.93 (20.1%) stddev-sans-first:19.57 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 141.0 94.0 94.0 94.0 130.0 95.0 95.0 128.0 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,650 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:2.58 (3.6%) stddev-sans-first:2.74 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 73.0 72.0 73.0 72.0 71.0 79.0 70.0 70.0 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 67.0 69.0 69.0 69.0 68.0 68.0 68.0 68.0 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:2.92 (3.5%) stddev-sans-first:3.10 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 93.0 83.0 84.0 84.0 84.0 85.0 86.0 83.0 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:3.43 (2.7%) stddev-sans-first:3.46 04:29:10 INFO - 2015-12-11 04:29:10,651 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 124.0 121.0 130.0 129.0 124.0 127.0 128.0 120.0 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.50 stddev:8.08 (5.3%) stddev-sans-first:8.13 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: Values: 144.0 140.0 151.0 165.0 155.0 152.0 151.0 158.0 157.0 140.0 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 73.0 71.0 71.0 71.0 70.0 73.0 73.0 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:10 INFO - 2015-12-11 04:29:10,652 DEBUG : BROWSER_OUTPUT: 04:29:11 INFO - 2015-12-11 04:29:11,536 INFO : Browser exited with error code: 0 04:29:11 INFO - 2015-12-11 04:29:11,587 INFO : Completed test kraken (00:01:01) 04:29:11 INFO - 2015-12-11 04:29:11,587 INFO : Starting test v8_7 04:29:11 INFO - 2015-12-11 04:29:11,587 DEBUG : operating with platform_type : linux_ 04:29:11 INFO - 2015-12-11 04:29:11,587 INFO : Initialising browser for v8_7 test... 04:29:11 INFO - 2015-12-11 04:29:11,593 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmEm8r/profile http://localhost:59040/getInfo.html 04:29:16 INFO - 2015-12-11 04:29:16,437 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:16 INFO - 2015-12-11 04:29:16,437 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:16 INFO - 2015-12-11 04:29:16,437 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:29:16 INFO - 2015-12-11 04:29:16,437 DEBUG : BROWSER_OUTPUT: __metrics 04:29:16 INFO - 2015-12-11 04:29:16,559 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] 04:29:16 INFO - 2015-12-11 04:29:16,621 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:16 ERROR - 2015-12-11 04:29:16,636 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:29:17 INFO - 2015-12-11 04:29:17,564 INFO : Browser initialized. 04:29:17 INFO - 2015-12-11 04:29:17,564 INFO : Running cycle 1/1 for v8_7 test... 04:29:17 INFO - 2015-12-11 04:29:17,565 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmEm8r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:29 INFO - 2015-12-11 04:29:29,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 04:29:29 INFO - 2015-12-11 04:29:29,591 DEBUG : BROWSER_OUTPUT: 04:29:50 INFO - 2015-12-11 04:29:50,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59040/tests/v8_7/run.html (next: http://localhost:59040/tests/v8_7/run.html) 04:29:51 INFO - 2015-12-11 04:29:51,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 445116416 04:29:51 INFO - 2015-12-11 04:29:51,230 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 04:29:51 INFO - 2015-12-11 04:29:51,231 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |6;Boyer;11870.588235294117 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |8;Splay;603.4897713598075 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: __startTimestamp1449836991224__endTimestamp 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:29:51 INFO - 2015-12-11 04:29:51,232 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: Values: 165.1 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: Values: 185.6 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: Values: 278.9 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: Values: 5138.5 04:29:51 INFO - 2015-12-11 04:29:51,233 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: Values: 2002.0 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: Values: 786.2 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11870.59 Median:11870.59 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: Values: 11870.6 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,234 DEBUG : BROWSER_OUTPUT: Values: 26921.1 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.49 Median:603.49 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: Values: 603.5 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:51 INFO - 2015-12-11 04:29:51,235 DEBUG : BROWSER_OUTPUT: 04:29:52 INFO - 2015-12-11 04:29:52,168 INFO : Browser exited with error code: 0 04:29:52 INFO - 2015-12-11 04:29:52,183 INFO : Completed test v8_7 (00:00:40) 04:29:52 INFO - 2015-12-11 04:29:52,271 INFO : Completed test suite (00:20:19) 04:29:52 INFO - 2015-12-11 04:29:52,272 DEBUG : Working with test: dromaeo_css 04:29:52 INFO - 2015-12-11 04:29:52,272 DEBUG : Generating results file: dromaeo_css 04:29:52 INFO - 2015-12-11 04:29:52,273 DEBUG : Working with test: kraken 04:29:52 INFO - 2015-12-11 04:29:52,273 DEBUG : Generating results file: kraken 04:29:52 INFO - 2015-12-11 04:29:52,273 INFO : javascript benchmark 04:29:52 INFO - 2015-12-11 04:29:52,273 DEBUG : Working with test: v8_7 04:29:52 INFO - 2015-12-11 04:29:52,273 DEBUG : Generating results file: v8_7 04:29:52 INFO - 2015-12-11 04:29:52,274 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:52 INFO - 2015-12-11 04:29:52,329 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 04:29:52 INFO - 2015-12-11 04:29:52,329 DEBUG : process_Request line: dromaeo_css 6274.53 graph.html#tests=[[72,203,35]] 04:29:52 INFO - 2015-12-11 04:29:52,329 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:52 INFO - 2015-12-11 04:29:52,356 DEBUG : process_Request line: kraken 1534.60 graph.html#tests=[[232,203,35]] 04:29:52 INFO - 2015-12-11 04:29:52,356 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:52 INFO - 2015-12-11 04:29:52,397 DEBUG : process_Request line: v8_7 19881.46 graph.html#tests=[[230,203,35]] 04:29:52 INFO - 2015-12-11 04:29:52,398 INFO : javascript benchmark 04:29:52 INFO - 2015-12-11 04:29:52,402 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2601.115620688966, 2724.782017438605, 2731.890724371025, 2746.752792248697, 2761.4339060492593, 4511.48117966434, 4651.767411629417, 4675.929861052087, 4696.201645720232, 4716.457607375153, 4513.210188217057, 4567.703099298543, 4638.397008388904, 4642.117997580457, 4762.618990480762, 4169.62473377396, 4285.357196420547, 4315.503717072537, 4330.891727706817, 4437.600615944564, 4384.561543845622, 4407.735535867842, 4440.178566965105, 4442.11157768446, 4484.573965473275, 4108.219438306712, 4214.178235244098, 4229.323308270693, 4313.870583882457, 4337.219300525904, 4316.870493885189, 4323.589259020388, 4325.178216138955, 4339.696221264513, 4365.12697460506, 4266.466691663542, 4290.420793192941, 4298.032942587893, 4325.048489332342, 4351.630111440531, 4400.7579583122915, 4478.910421791578, 4491.887702807423, 4533.546645335473, 4639.884002899955, 4974.552290293891, 5003.224500202475, 5004.974975125101, 5008.398992120932, 5047.9747601262125, 5028.673136246132, 5030.0, 5031.798728050873, 5039.3448851649055, 5047.217681259411, 4572.0627271409285, 4636.304554316879, 4687.718736875799, 4698.553637404441, 4768.61851051915, 5224.660397074178, 5251.658642188246, 5256.894862102737, 5260.316158899319, 5266.34170728659, 5027.120253955543, 5038.370203724535, 5045.672031317952, 5050.84847454577, 5094.439611642716, 4867.3915760529935, 4886.65793394459, 4989.451160372356, 4995.725235112031, 4998.600111991032, 5060.291559181717, 5063.670861394071, 5071.923921141186, 5096.23556466533, 5107.61692873036, 5039.5968322534845, 5040.84877453677, 5044.974775126101, 5047.520485553867, 5085.567726743268, 4058.8782336529953, 4204.2432362175105, 4266.146770645822, 4269.765162916069, 4319.935200971988, 3537.646235376442, 3608.4226523756074, 3632.20091579852, 3652.36083685354, 3713.053171441265, 4336.306191009423, 4353.1293741251875, 4354.433923589913, 4364.60718535327, 4397.73613583186, 4819.831305904277, 4936.975315123402, 5092.414372347153, 5099.796008159632, 5139.717315547681, 4210.936835947463, 4278.743275403485, 4298.097399546068, 4306.956930430718, 4307.827686892552, 4449.510553839075, 4492.326151077365, 4494.4157259556705, 4504.594586487232, 4533.637309015271, 4755.524447555217, 4760.214564596803, 4762.761861906891, 4766.571008609242, 4809.110314591811, 4809.038192361611, 4900.754962251945, 4927.507249275044, 4989.775460104232, 5077.669951453291, 4825.9034819304115, 4834.347363106076, 4838.612910967185, 4841.830535931225, 4882.902341953212, 5029.572486338702, 5051.873703157304, 5052.292679025013, 5053.343065401475, 5054.898902022012, 4767.33257343979, 4910.8281210157475, 4921.064997650435, 5127.692338459704, 5163.767630456563, 4895.069936712013, 4983.327250821093, 4985.551300382983, 4995.050940321327, 5021.372328458942, 4877.6829506081995, 4908.214685650421, 4921.655484116078, 4930.309756634002, 4974.054929563371, 4639.721616703008, 4755.5719985201495, 4757.952420475751, 4825.10735513931, 4876.146674332049, 4869.926951095807, 4955.776990035529, 4957.776900039435, 4980.203167493184, 5001.224810154432, 4830.7826147822725, 4858.92711609319, 4863.440704318907, 4863.659543831898, 4901.828436004723], "unit": "ms", "name": "dojo.html", "value": 4614.231590676603}, {"lowerIsBetter": false, "replicates": [541.7908069399443, 561.1918836874902, 573.263356586786, 590.5452801342966, 593.2910172344048, 26276.211713648598, 36104.27791444169, 36109.81945090274, 36439.81780091096, 36484.817575912115, 39997.800010999905, 40619.187616247735, 40640.79679601598, 40673.796631016805, 40710.0, 7030.26182250864, 7081.787546373617, 7862.095858976205, 8041.55771432571, 8056.39577031722, 7086.0, 10127.442990635513, 10335.638252661158, 10353.223508236875, 10356.119729822974, 9899.109080182781, 9934.155596774282, 10003.0, 10010.34932729374, 10035.949820250926, 7282.563046217244, 9860.950695246549, 10021.949890250502, 10026.448545330004, 10036.19710423168, 7176.748813791544, 9943.303968722192, 10320.896791032068, 10325.122364599018, 10339.79320413595, 37525.624743752756, 37974.620253797664, 37990.62009379926, 37994.24011519754, 38002.42996355057, 2811.4236581500745, 2855.486012517746, 3321.4353559894876, 3565.3047655707146, 3614.078410005458, 28220.294492637644, 28293.15120546387, 28701.712982870322, 28815.711842881512, 29475.115746527637, 3172.3338098999006, 3252.4308246056844, 3262.151840521458, 3314.3371325734947, 3349.949750753741, 210545.0, 211010.88989110067, 211034.0, 211128.0, 211131.0, 54914.725426373414, 55260.0, 55287.44712552823, 55299.723501382236, 55342.72328638411, 59291.70354148201, 59450.40549594535, 59477.97047398546, 59533.0, 59537.40462595318, 12321.383930803424, 12679.175853569674, 12686.873131268754, 12695.55565555201, 12705.745885082246, 9986.700398988041, 10028.047335503115, 10050.396976181453, 10051.547680354402, 10056.245781566266, 18750.24999000052, 18777.530561736065, 18814.717779233324, 18855.43433696964, 18901.0, 7266.0, 7481.177070522238, 7555.16893141754, 7605.353544948631, 7656.196099409593, 792.6868886789802, 799.7720649614832, 916.225789208118, 957.989321266057, 1037.1650821088945, 26187.869060654575, 26470.882329413602, 26846.0, 26908.192754217405, 26953.191404257905, 809.1423091523004, 826.557791581513, 931.65063101337, 937.6905621145143, 956.3496822160997, 11729.589464368877, 12125.757484850254, 12532.749345013048, 12611.621651350475, 13138.934305328412, 245607.0, 252015.0, 252289.0, 252528.0, 252612.0, 45053.0, 45295.77352113284, 45334.0, 45372.77313613411, 45375.773121134844, 1070.3203465799274, 1121.472907733364, 1126.5437497813398, 1227.8096894981293, 1230.2802860326808, 23460.64809027832, 23869.761302387447, 26341.34146646349, 26527.204183874514, 26604.733952661, 36164.45753313755, 36521.52177173445, 36531.81734091313, 36556.81721591375, 36616.63383366239, 174544.0, 175620.0, 175627.12186438986, 175768.0, 175993.0, 26669.59995600029, 26697.0, 27029.0, 27058.72941270562, 27171.456570868868, 36582.0, 36805.815970919975, 37298.0, 37404.0, 37542.624573753914, 31704.841475792473, 31784.523232151998, 31875.52186717155, 32062.358752824348, 32221.838890805397, 31717.0, 31968.52047219247, 34545.81812728111, 35960.0, 36423.0, 32017.67982320147, 37587.0, 37729.81135094417, 37774.24451510899, 40614.39078413885, 32162.678373216906, 33031.66968330382, 33417.0, 34109.65890341164, 36580.26839463143, 27665.861670691516, 28519.572206417335, 28675.56986645244, 28861.56707649345, 28931.0], "unit": "ms", "name": "ext.html", "value": 16924.564139863578}, {"lowerIsBetter": false, "replicates": [335.9395308844408, 336.48685754224806, 338.50578155892396, 340.3227577121529, 340.45357201691286, 12588.055895807805, 12920.54778082765, 14741.189234592093, 14994.997685496277, 16546.255418506167, 12859.742805143891, 15079.849201507981, 15330.233488325595, 15637.687246255096, 15670.529884103495, 4660.091282199973, 4664.740520059599, 4671.719696818185, 4856.125897338477, 4860.441049279334, 3764.1530655602546, 3865.1496670732395, 5057.2666963290485, 5640.830775076754, 5829.912551311712, 5726.255586773714, 5726.828195154152, 5748.0, 5766.855828604297, 5770.33641131269, 5696.259486266779, 5904.616199947011, 5906.37983011784, 5921.822345329604, 5931.822045338647, 5180.3265575475325, 5180.378354597435, 5182.455842136559, 5196.272521846944, 5198.818041368571, 18416.53958651031, 18766.155523001496, 18833.905830470896, 19159.329423470113, 19662.80337196624, 1758.9208485618178, 1808.1411329618456, 1862.0503543192933, 1940.631854542544, 1974.3978086683555, 8357.289630381425, 8559.657613695445, 8608.31133509324, 8791.736247912573, 8832.293416526727, 1677.447648284171, 1709.265016043101, 1725.843684731233, 1729.5416714570524, 1771.2118107442193, 54205.1869221962, 55257.723711381586, 56185.43814561843, 56263.0, 57271.71364143194, 9622.807543849083, 9635.373700709431, 9637.132658060807, 9725.513724313898, 9829.754256143653, 12410.193337433038, 12415.317157556241, 12430.689232769073, 12434.129610927148, 12441.564545240873, 6565.0, 6657.400833924873, 6756.223034351015, 6783.38949494538, 6808.114945057111, 6509.251436084816, 6586.901196482057, 6612.702428390734, 6655.0682904393425, 6685.799426017227, 4009.498812648419, 4045.716799824043, 4134.958650413458, 4181.91636167281, 4210.073783767566, 1619.1094897806395, 1656.8011838579207, 1661.3188592676945, 1666.858317043065, 1692.2638652186338, 744.4751450227576, 803.5660743198607, 883.5273128876021, 892.9866052009226, 972.837459236206, 14638.926805366118, 15079.262535407115, 15305.387784488496, 15553.30010149546, 16094.275757590936, 702.3994484715597, 807.7657479330928, 816.77946954322, 843.5487014447364, 859.0679113162289, 8325.8334833303, 8946.329025323126, 9079.364444488823, 9386.249100071978, 9618.807623847484, 489119.0, 493213.0, 493434.0, 500969.0, 512707.0, 72052.63973680203, 74275.25724742791, 75803.62098189474, 75860.62069689616, 76134.0, 1016.8779746430475, 1042.296449896317, 1049.1082579807103, 1051.24835742443, 1053.4890578069783, 14073.366698498387, 14387.712245755236, 14481.47944465816, 14738.63153421173, 15202.087874727551, 34853.65146348504, 34900.47649285314, 35192.22897760797, 35275.82362088173, 35366.46950295799, 39248.21503569856, 39355.0, 39483.802580988064, 40658.0, 40982.38526422166, 8363.916360836314, 8382.874256886029, 8445.746627601182, 8590.1839325264, 8795.692150774692, 10100.646477373257, 13277.40251688657, 14934.626634334229, 15055.473058442902, 16036.438724645048, 12681.048921330752, 12977.870221297666, 13167.60497185086, 13603.727925441237, 13769.105008174436, 2248.2018883296196, 9502.85745713801, 13035.914253719739, 13053.303467004946, 13252.734945301232, 10684.83972740394, 13988.860111398755, 14232.857671423568, 14393.64015899569, 14400.0, 7432.554046757212, 7513.2862378074, 7519.736809211651, 8559.786005349915, 8740.125987401208, 12189.51241950312, 12527.310997895203, 12688.74622507563, 12696.809547856974, 12922.870771292166], "unit": "ms", "name": "jquery.html", "value": 8106.3537822542285}, {"lowerIsBetter": false, "replicates": [1233.9074569407296, 1644.572411173095, 1666.1336105225282, 1682.9410970616032, 1715.7340612205105, 5890.793822216223, 6715.66421678916, 6859.794206173817, 6881.449484041277, 6898.724051037952, 6722.193336799579, 6863.691133898974, 6914.8271293217695, 6916.58500489971, 6937.653117344138, 2010.6581881080251, 2054.938351849447, 2056.9382918512392, 2058.660321047033, 2060.701198326242, 2090.6759452284846, 2126.680997850327, 2133.797289257518, 2142.7857214278524, 2146.892655367233, 2093.8534302598746, 2100.01797447624, 2113.8837363944976, 2136.380449669594, 2137.465633591602, 2033.3290014295394, 2033.7762846086919, 2065.1120018392085, 2066.2664754012335, 2067.214458505766, 2027.9594408111902, 2059.742532183477, 2065.173930427826, 2066.4627196928755, 2077.9480512987298, 6905.585664860125, 7000.719971201146, 7011.544249623758, 7016.0, 7039.120109986252, 4152.0, 4207.221663992141, 4215.3887686285625, 4217.704760666755, 4232.132412855388, 2635.9868200659066, 2648.3511539672904, 2667.7065522792477, 2694.0436145168574, 2705.5400581900926, 816.5835423933777, 819.737683941139, 828.6022709099666, 840.6759354017386, 849.4818160921833, 9422.905770942272, 9428.575714092814, 9436.245100391952, 9437.480938548377, 9443.952780236055, 3932.3511620582285, 3937.8031098444962, 3991.640752332246, 3994.960050399517, 4019.8392064317686, 8085.393595480363, 8127.146649601825, 8127.431079824474, 8151.388645851466, 8159.632816523271, 4249.065205654751, 4262.46719160105, 4281.165172791338, 4285.485741710952, 4291.399204111427, 3267.8856240031487, 3357.1774915145947, 3775.207206486614, 3872.9612703873163, 3880.262750077476, 3311.8344082795766, 3316.286998295378, 3337.4826901830256, 3337.6829201225846, 3351.631320554737, 1049.800537897797, 1064.3826580583243, 1065.515190588296, 1065.6696424108552, 1073.3184427888348, 822.0915887943855, 860.9784755381165, 1143.5540139345662, 1186.3534373766317, 1191.559123124432, 6120.234970628671, 6141.263048434216, 6146.477549408351, 6159.722812473449, 6168.444839964424, 1037.5019990404649, 1049.6955882794057, 1055.7413433708791, 1060.3743791163251, 1065.3680836790913, 5321.3348331458565, 5354.732263386815, 5361.0, 5362.142057270896, 5367.919481207785, 8211.794705132419, 8311.127331630212, 8528.104549022388, 8528.232459078712, 8532.658693652184, 8317.542535160625, 8351.039630442456, 8431.873521897176, 8446.957765211257, 8473.95763021181, 6076.149339092531, 6333.68331583419, 6609.438197753245, 6668.166479190101, 6675.299093595199, 6704.363085506869, 6853.554518956252, 6860.176778786577, 6868.690908909211, 6868.862622747617, 7386.889196661947, 7573.242675732383, 7593.696252149852, 7654.617269136632, 7660.463767536442, 7670.961645191738, 7822.882656760039, 7885.44801863864, 7895.131535531202, 7982.560959147303, 5647.576431767716, 5771.7402716877, 6578.309277525982, 6617.205935287796, 6661.267260601233, 6331.3352098029045, 6334.493240540838, 6350.936490635219, 6450.548461607643, 6508.511861610304, 6052.2132122825515, 6297.590656607306, 6322.209723784527, 6345.079963405188, 6447.6131432114225, 6027.397260273938, 6066.575339726177, 6102.267727872683, 6104.145419641165, 6320.115183874169, 6157.568970172045, 6165.445109940127, 6179.196704428396, 6200.100985357008, 6210.596311239755, 5756.597038207286, 5796.42035796417, 5808.73860676279, 5818.0, 5820.534357251325, 5697.715114244188, 5746.310442746897, 5782.3639399666845, 5858.1558172191935, 5861.238039054895], "unit": "ms", "name": "mootools.html", "value": 4038.7037618554486}, {"lowerIsBetter": false, "replicates": [302.895501052137, 306.9585605943197, 308.39246684032463, 311.90486901495046, 314.7198992896322, 5309.123994540901, 5397.784088636455, 5481.671099734019, 5521.089020311644, 5532.502074813266, 5338.145896656536, 5380.354357477098, 5410.0, 5410.377806552247, 5434.510894019538, 3922.1567363016948, 4019.055521952339, 4159.417681524581, 4160.147169830193, 4168.520620128694, 4059.0867054912705, 4143.523494798092, 4160.105577300879, 4161.188568229197, 4165.250254954107, 4096.97951510242, 4099.61053699898, 4107.28122578549, 4111.177764447108, 4111.48606424197, 3895.1625400538737, 3987.6610488108545, 4009.3184158693093, 4089.161721847014, 4106.384042393635, 3563.55455568054, 3573.5175751273505, 3576.5708115026105, 3584.62361452049, 3591.425371940477, 5078.542931136216, 5085.5931525478245, 5091.981603679279, 5096.79612815487, 5100.5919526438165, 4728.38530990969, 4738.644601654855, 4740.834070807539, 4746.098241334135, 4751.239801631722, 5466.234727138204, 5650.29371328584, 5657.547396208334, 5659.60382773206, 5670.914936275959, 3898.3372826619543, 3918.941215881764, 3919.314120029012, 3923.8234279457492, 3925.568187499373, 5904.143899134644, 5987.461128498412, 5992.2809262888295, 5996.400359964013, 6003.739214764904, 4038.757674539537, 4043.7169398142437, 4046.089629833264, 4048.2713111640187, 4055.1078762672164, 3792.924141517154, 3868.323043467382, 4076.0421300994244, 4102.610252026053, 4105.67154627629, 4634.096351211549, 4723.716577005391, 4733.242681170997, 4742.881427964328, 4743.928841067387, 5684.8294551163535, 5686.061799802987, 5689.630174038757, 5706.80026199081, 5707.6575405475805, 1436.2531483628454, 1453.7601295786076, 1455.3305479479345, 1455.9344829482698, 1456.410153887677, 966.7728083900278, 968.0271327316002, 975.1954637424153, 989.1690979577046, 989.3964681544252, 4977.800887964513, 4977.950220497821, 4983.103041452501, 4983.327250821093, 4987.326710894055, 5921.881562368729, 5922.052471604608, 5930.080837470113, 5931.73307201177, 5934.851628709317, 4976.2286845539, 4978.153713868579, 4980.950190498121, 4981.2030075187795, 4982.800687972513, 3069.6469905960653, 3152.590163278759, 3172.1118086935694, 3187.729043031322, 3194.6645602211897, 5500.147477141049, 5511.118221084607, 5528.391876893538, 5538.556915446755, 5542.140968149863, 6064.483239455665, 6070.969645151746, 6078.483328917003, 6078.601921558066, 6079.939200607937, 5403.7838486460105, 5518.2826232589505, 5521.503064724194, 5528.087865502228, 5535.501804837584, 5882.323532793784, 5895.882082358415, 5896.941030589639, 5902.1736956826935, 5910.172575839472, 5746.109353050284, 5750.6485975796495, 5751.252337196138, 5753.050746626927, 5764.6829424380385, 5537.197106419466, 5540.944590554204, 5541.168824676331, 5546.750396232099, 5550.861228469321, 4038.6163314485075, 4052.250333688277, 4056.5537790842395, 4150.086980864205, 4168.103857670615, 5656.179853921076, 5740.770369185186, 5807.680577568274, 5859.648421094748, 5903.203067585821, 5499.1476321170285, 5662.66024038559, 5665.631733937281, 5667.4615911488345, 5675.545956323567, 5711.257536520392, 5713.9428605715075, 5723.771049157987, 5724.513416359656, 5726.341470730919, 5403.13549832025, 5594.328680558359, 5595.972020140036, 5598.720063996865, 5602.299712535933, 5707.800226992202, 5739.71301434935, 5747.770089196385, 5785.218995435563, 5798.10129429939, 5642.069058605284, 5650.660960342392, 5662.915056274077, 5663.4053424391495, 5665.235193248858], "unit": "ms", "name": "prototype.html", "value": 4243.348256985438}, {"lowerIsBetter": false, "replicates": [669.3574168797953, 716.0226291112633, 749.673891857042, 751.6692655231698, 760.1068744225535, 10765.0, 11019.614313499029, 11020.283681560693, 11026.779464410716, 11027.944860275697, 11078.501467433965, 11226.831597526043, 11237.101031917447, 11329.037031852282, 11340.0, 623.5261201486858, 630.0, 794.5034353529045, 796.358931060496, 807.7374853172713, 805.1103530598663, 811.9391045671598, 812.0, 812.6018251056969, 816.3265306122443, 848.0247715127591, 849.4818160921864, 849.6771226933756, 849.995750021249, 850.3962186847315, 649.0653459019021, 655.3217419970308, 833.6207025803275, 846.2426128614856, 847.6100993542977, 629.6725702634604, 630.0203184048802, 630.486153784664, 630.7729217481703, 631.2582715309493, 10777.622783202629, 11005.394703291317, 11114.722131946684, 11161.107111431065, 11184.552617895275, 10224.233182511342, 10422.9478852606, 10732.302400343953, 11181.832272515838, 11388.658340249805, 8664.523451210182, 8700.477971321741, 9169.908300917039, 9192.540372981324, 9854.113129818279, 3241.286916878283, 3272.5091236314743, 3291.308825146722, 3303.289792694582, 3310.519974603693, 41075.794621027, 41734.79132604348, 41926.371104433456, 42333.15333693309, 42446.57553424457, 9278.11857873501, 9368.156865881967, 9425.104615061558, 9442.339036267533, 9459.621615135455, 16050.518484445485, 16066.518004459886, 16096.195190240442, 16097.517074487783, 16101.436449724204, 6193.4425901669065, 6245.781397651152, 6313.355595139439, 6504.804855854332, 6515.51133664977, 3266.1508007917637, 3338.966610333914, 3558.5373901392654, 3608.566971963381, 3609.8375573099274, 2577.76800087993, 2596.805239607037, 2614.045873256248, 2616.149751330825, 2617.646617706623, 445.243086752522, 456.752776340406, 456.9977150114228, 460.9101225261042, 501.22810871257855, 493.8000109955402, 516.8837011672343, 543.1825103219629, 553.3912696034411, 565.7793460550389, 7474.663640136098, 7666.3866890648615, 7703.34521565662, 7853.293203611703, 8004.319632831274, 410.704292909105, 447.8589244388007, 504.6921377959442, 528.9365276166884, 539.5872157799287, 3394.8390884080713, 3503.562054743157, 3581.2093953023486, 3645.8177091145335, 3667.284879448482, 50979.23531147036, 51129.60879890014, 51265.7436712814, 51441.742791285804, 51873.740631297354, 45867.77066114648, 45873.0, 46117.76941115273, 46231.76884115558, 46791.0, 41140.38289425661, 41319.38020929688, 41391.0, 42234.0, 42360.78819605882, 7168.24733403006, 7246.239144889711, 8034.709146517713, 8058.153893841062, 8346.791330216793, 28812.711872881002, 29337.0, 29379.265518361357, 29548.704512954595, 29930.700692992792, 38116.42825357677, 39804.20391592094, 40504.392434112924, 41141.0, 41146.794266028475, 9822.75443113928, 9940.403575785476, 10021.649242276486, 10066.295359324777, 10146.644867429604, 10440.477976101316, 10475.94762026185, 11348.54605815758, 11554.306741595195, 11602.825957610474, 10177.796444071226, 10225.488725563544, 10569.312994655324, 10999.670009899715, 11153.275037122885, 10228.744281392726, 10385.896141038493, 10438.0, 10700.571977120828, 10995.34027958325, 9748.171405430334, 9810.901890980998, 10074.8488772667, 10200.59197632116, 10461.9476902615, 9433.24534037289, 9655.0, 9686.56410461545, 9806.264530160124, 9844.3601165924, 9270.397424167408, 9609.471479068718, 9640.517974101407, 9653.517324133905, 9663.710088697351], "unit": "ms", "name": "yui.html", "value": 5624.036918366689}], "name": "dromaeo_css", "value": 6274.5281296780295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 111.0, 114.0, 114.0, 101.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [151.0, 132.0, 157.0, 184.0, 139.0, 157.0, 161.0, 136.0, 164.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 90.0, 97.0, 72.0, 72.0, 73.0, 101.0, 99.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 141.0, 94.0, 94.0, 94.0, 130.0, 95.0, 95.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 72.0, 73.0, 72.0, 71.0, 79.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 93.0, 83.0, 84.0, 84.0, 84.0, 85.0, 86.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 124.0, 121.0, 130.0, 129.0, 124.0, 127.0, 128.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [144.0, 140.0, 151.0, 165.0, 155.0, 152.0, 151.0, 158.0, 157.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 73.0, 71.0, 71.0, 71.0, 70.0, 73.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1534.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [11870.588235294117], "unit": "score", "name": "Boyer", "value": 56.1440584737364}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [603.4897713598075], "unit": "score", "name": "Splay", "value": 135.03294317048852}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19881.45835034831}]} 04:29:52 INFO - RETURN: dromaeo_css: 6274.53 04:29:52 INFO - RETURN: kraken: 1534.60 04:29:52 INFO - RETURN: v8_7: 19881.46 04:29:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19881.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1534.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6274.53"}}} 04:29:52 INFO - Return code: 0 04:29:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:52 ERROR - # TBPL SUCCESS # 04:29:52 INFO - Running post-action listener: _resource_record_post_action 04:29:52 INFO - Running post-run listener: _resource_record_post_run 04:29:53 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513064960; Read time: 12; Write time: 671756 04:29:53 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 201273344; Read time: 0; Write time: 441212 04:29:53 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269443072; Read time: 12; Write time: 210884 04:29:53 INFO - Running post-run listener: _upload_blobber_files 04:29:53 INFO - Blob upload gear active. 04:29:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:29:53 INFO - Copying logs to upload dir... 04:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.954052 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-11 04:29:53.546788) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:29:53.550524) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009988 build_url: 'https://queue.taskcluster.net/v1/task/ancwlKTYQlSnzSgpf4Wjhg/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-11 04:29:53.602906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:29:53.603291) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1449827469.722411-239104628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:29:53.653322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:29:53.653703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:29:53.654029) ========= ========= Total master_lag: 0.23 =========