builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1450328858.92 results: success (0) buildid: 20151216194533 builduid: b66602e6ad4d4dc6937b15c99b16c2ec revision: 77ab820ce477438af4b32cea83f82fd55744cec7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:38.923343) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:38.923852) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:38.924172) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006412 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:38.957818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:38.958205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.051964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.052261) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.104719) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.105085) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.105542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.105842) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 21:07:39-- 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% 224M=0s 2015-12-16 21:07:40 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.299121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.299506) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017576 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.348583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.348935) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 77ab820ce477438af4b32cea83f82fd55744cec7 --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 77ab820ce477438af4b32cea83f82fd55744cec7 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 21:07:40,224 truncating revision to first 12 chars 2015-12-16 21:07:40,224 Setting DEBUG logging. 2015-12-16 21:07:40,224 attempt 1/10 2015-12-16 21:07:40,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/77ab820ce477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 21:07:40,538 unpacking tar archive at: b2g-inbound-77ab820ce477/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.953228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.953692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.962578) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.962982) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 21:07:39.963574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-16 21:07:39.964011) ========= /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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:07:40 INFO - MultiFileLogger online at 20151216 21:07:40 in /builds/slave/test 21:07:40 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 21:07:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:07:40 INFO - {'append_to_log': False, 21:07:40 INFO - 'base_work_dir': '/builds/slave/test', 21:07:40 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 21:07:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:07:40 INFO - 'branch': 'B2G-Inbound-Non-PGO', 21:07:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:07:40 INFO - 'config_files': ('talos/linux_config.py',), 21:07:40 INFO - 'default_actions': ('clobber', 21:07:40 INFO - 'read-buildbot-config', 21:07:40 INFO - 'download-and-extract', 21:07:40 INFO - 'populate-webroot', 21:07:40 INFO - 'create-virtualenv', 21:07:40 INFO - 'install', 21:07:40 INFO - 'run-tests'), 21:07:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:07:40 INFO - 'download_minidump_stackwalk': True, 21:07:40 INFO - 'download_symbols': 'ondemand', 21:07:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:07:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:07:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:07:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:07:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:07:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:07:40 INFO - 'installer_path': 'installer.exe', 21:07:40 INFO - 'log_level': 'info', 21:07:40 INFO - 'log_name': 'talos', 21:07:40 INFO - 'log_to_console': True, 21:07:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:07:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:07:40 INFO - 'opt_config_files': (), 21:07:40 INFO - 'pip_index': False, 21:07:40 INFO - 'sps_profile': False, 21:07:40 INFO - 'sps_profile_interval': 0, 21:07:40 INFO - 'suite': 'dromaeojs', 21:07:40 INFO - 'system_bits': '64', 21:07:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:07:40 INFO - 'title': 'talos-linux64-ix-035', 21:07:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:07:40 INFO - 'use_talos_json': True, 21:07:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:07:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:07:40 INFO - 'work_dir': 'build'} 21:07:40 INFO - ##### 21:07:40 INFO - ##### Running clobber step. 21:07:40 INFO - ##### 21:07:40 INFO - Running pre-action listener: _resource_record_pre_action 21:07:40 INFO - Running main action method: clobber 21:07:40 INFO - rmtree: /builds/slave/test/build 21:07:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:07:41 INFO - Running post-action listener: _resource_record_post_action 21:07:41 INFO - ##### 21:07:41 INFO - ##### Running read-buildbot-config step. 21:07:41 INFO - ##### 21:07:41 INFO - Running pre-action listener: _resource_record_pre_action 21:07:41 INFO - Running main action method: read_buildbot_config 21:07:41 INFO - Using buildbot properties: 21:07:41 INFO - { 21:07:41 INFO - "properties": { 21:07:41 INFO - "buildnumber": 786, 21:07:41 INFO - "product": "firefox", 21:07:41 INFO - "script_repo_revision": "production", 21:07:41 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 21:07:41 INFO - "repository": "", 21:07:41 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 21:07:41 INFO - "buildid": "20151216194533", 21:07:41 INFO - "slavename": "talos-linux64-ix-035", 21:07:41 INFO - "pgo_build": "False", 21:07:41 INFO - "basedir": "/builds/slave/test", 21:07:41 INFO - "project": "", 21:07:41 INFO - "platform": "ubuntu64_hw", 21:07:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:07:41 INFO - "slavebuilddir": "test", 21:07:41 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 21:07:41 INFO - "branch": "b2g-inbound", 21:07:41 INFO - "repo_path": "integration/b2g-inbound", 21:07:41 INFO - "stage_platform": "linux64", 21:07:41 INFO - "builduid": "b66602e6ad4d4dc6937b15c99b16c2ec", 21:07:41 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 21:07:41 INFO - }, 21:07:41 INFO - "sourcestamp": { 21:07:41 INFO - "repository": "", 21:07:41 INFO - "hasPatch": false, 21:07:41 INFO - "project": "", 21:07:41 INFO - "branch": "b2g-inbound-linux64-talos", 21:07:41 INFO - "changes": [ 21:07:41 INFO - { 21:07:41 INFO - "category": null, 21:07:41 INFO - "files": [ 21:07:41 INFO - { 21:07:41 INFO - "url": null, 21:07:41 INFO - "name": "https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 21:07:41 INFO - } 21:07:41 INFO - ], 21:07:41 INFO - "repository": "", 21:07:41 INFO - "rev": "77ab820ce477438af4b32cea83f82fd55744cec7", 21:07:41 INFO - "who": "echen@mozilla.com", 21:07:41 INFO - "when": 1450328779, 21:07:41 INFO - "number": 7370458, 21:07:41 INFO - "comments": "Bug 1200928 - Part 2: [Taskcluster] Use correct busybox binary for x86/arm emulator when running xpcshell tests. r=garndt", 21:07:41 INFO - "project": "", 21:07:41 INFO - "at": "Wed 16 Dec 2015 21:06:19", 21:07:41 INFO - "branch": "b2g-inbound-linux64-talos", 21:07:41 INFO - "revlink": "", 21:07:41 INFO - "properties": [ 21:07:41 INFO - [ 21:07:41 INFO - "buildid", 21:07:41 INFO - "20151216194533", 21:07:41 INFO - "Change" 21:07:41 INFO - ], 21:07:41 INFO - [ 21:07:41 INFO - "builduid", 21:07:41 INFO - "b66602e6ad4d4dc6937b15c99b16c2ec", 21:07:41 INFO - "Change" 21:07:41 INFO - ], 21:07:41 INFO - [ 21:07:41 INFO - "pgo_build", 21:07:41 INFO - "False", 21:07:41 INFO - "Change" 21:07:41 INFO - ] 21:07:41 INFO - ], 21:07:41 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 21:07:41 INFO - } 21:07:41 INFO - ], 21:07:41 INFO - "revision": "77ab820ce477438af4b32cea83f82fd55744cec7" 21:07:41 INFO - } 21:07:41 INFO - } 21:07:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:07:41 INFO - Running post-action listener: _resource_record_post_action 21:07:41 INFO - ##### 21:07:41 INFO - ##### Running download-and-extract step. 21:07:41 INFO - ##### 21:07:41 INFO - Running pre-action listener: _resource_record_pre_action 21:07:41 INFO - Running main action method: download_and_extract 21:07:41 INFO - mkdir: /builds/slave/test/build/tests 21:07:41 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')]} 21:07:41 INFO - https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/test_packages.json 21:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/test_packages.json 21:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:07:46 INFO - Downloaded 1302 bytes. 21:07:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:07:46 INFO - Using the following test package requirements: 21:07:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:07:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'jsshell-linux-x86_64.zip'], 21:07:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:07:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:07:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:07:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:07:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:07:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:07: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')]} 21:07:46 INFO - https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:52 INFO - Downloaded 21869124 bytes. 21:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:07:53 INFO - Return code: 0 21:07:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:53 INFO - https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:54 INFO - Downloaded 21869124 bytes. 21:07:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:07:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:07:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:07:55 INFO - Return code: 0 21:07:55 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')]} 21:07:55 INFO - https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:07:56 INFO - Downloaded 11132052 bytes. 21:07:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 21:07:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:07:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:07:56 INFO - Return code: 0 21:07: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')]} 21:07:56 INFO - https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:07:58 INFO - Downloaded 57743010 bytes. 21:07:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:07:58 INFO - mkdir: /builds/slave/test/properties 21:07:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:07:58 INFO - Writing to file /builds/slave/test/properties/build_url 21:07:58 INFO - Contents: 21:07:58 INFO - build_url:https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:07:58 INFO - Running post-action listener: _resource_record_post_action 21:07:58 INFO - Running post-action listener: set_extra_try_arguments 21:07:58 INFO - ##### 21:07:58 INFO - ##### Running populate-webroot step. 21:07:58 INFO - ##### 21:07:58 INFO - Running pre-action listener: _resource_record_pre_action 21:07:58 INFO - Running main action method: populate_webroot 21:07:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:07:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:07:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:07:58 INFO - '--tppagecycles', 21:07:58 INFO - '7'], 21:07:58 INFO - 'tests': ['tsvgm']}}, 21:07:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:07:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:07:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:07:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:07:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'tests': ['damp', 'tps']}, 21:07:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['damp', 'tps']}, 21:07:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:07:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:07:58 INFO - 'other': {'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'other_l64': {'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'other_nol64': {'tests': ['a11yr', 21:07:58 INFO - 'ts_paint', 21:07:58 INFO - 'tpaint', 21:07:58 INFO - 'sessionrestore', 21:07:58 INFO - 'sessionrestore_no_auto_restore']}, 21:07:58 INFO - 'svgr': {'tests': ['tsvgx', 21:07:58 INFO - 'tsvgr_opacity', 21:07:58 INFO - 'tart', 21:07:58 INFO - 'tscrollx', 21:07:58 INFO - 'cart']}, 21:07:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['tsvgx', 21:07:58 INFO - 'tsvgr_opacity', 21:07:58 INFO - 'tart', 21:07:58 INFO - 'tscrollx', 21:07:58 INFO - 'cart']}, 21:07:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'tests': ['tp5o']}, 21:07:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'talos_options': ['--e10s'], 21:07:58 INFO - 'tests': ['tp5o']}, 21:07:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'talos_options': ['--xperf_path', 21:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:58 INFO - 'tests': ['tp5n']}, 21:07:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:58 INFO - 'talos_options': ['--e10s', 21:07:58 INFO - '--xperf_path', 21:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:58 INFO - 'tests': ['tp5n']}}, 21:07:58 INFO - 'talos.zip': {'path': '', 21:07:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:07:58 INFO - Running post-action listener: _resource_record_post_action 21:07:58 INFO - ##### 21:07:58 INFO - ##### Running create-virtualenv step. 21:07:58 INFO - ##### 21:07:58 INFO - Running pre-action listener: _resource_record_pre_action 21:07:58 INFO - Running main action method: create_virtualenv 21:07:58 INFO - Creating virtualenv /builds/slave/test/build/venv 21:07:58 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 21:07:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:07:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:07:58 INFO - Using real prefix '/usr' 21:07:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:07:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:00 INFO - Installing pip.................done. 21:08:00 INFO - Return code: 0 21:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:08:00 INFO - Using env: {'DISPLAY': ':0', 21:08:00 INFO - 'HOME': '/home/cltbld', 21:08:00 INFO - 'LANG': 'en_US.UTF-8', 21:08:00 INFO - 'LANGUAGE': 'en_US:en', 21:08:00 INFO - 'LOGNAME': 'cltbld', 21:08:00 INFO - 'MAIL': '/var/mail/cltbld', 21:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:00 INFO - 'MOZ_NO_REMOTE': '1', 21:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:00 INFO - 'NO_EM_RESTART': '1', 21:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:00 INFO - 'PWD': '/builds/slave/test', 21:08:00 INFO - 'SHELL': '/bin/bash', 21:08:00 INFO - 'SHLVL': '1', 21:08:00 INFO - 'TERM': 'linux', 21:08:00 INFO - 'TMOUT': '86400', 21:08:00 INFO - 'USER': 'cltbld', 21:08:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:00 INFO - '_': '/tools/buildbot/bin/python'} 21:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:01 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 21:08:01 INFO - Cleaning up... 21:08:01 INFO - Return code: 0 21:08:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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', '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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 21:08: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 psutil>=0.7.1 21:08:01 INFO - Using env: {'DISPLAY': ':0', 21:08:01 INFO - 'HOME': '/home/cltbld', 21:08:01 INFO - 'LANG': 'en_US.UTF-8', 21:08:01 INFO - 'LANGUAGE': 'en_US:en', 21:08:01 INFO - 'LOGNAME': 'cltbld', 21:08:01 INFO - 'MAIL': '/var/mail/cltbld', 21:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:01 INFO - 'MOZ_NO_REMOTE': '1', 21:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:01 INFO - 'NO_EM_RESTART': '1', 21:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:01 INFO - 'PWD': '/builds/slave/test', 21:08:01 INFO - 'SHELL': '/bin/bash', 21:08:01 INFO - 'SHLVL': '1', 21:08:01 INFO - 'TERM': 'linux', 21:08:01 INFO - 'TMOUT': '86400', 21:08:01 INFO - 'USER': 'cltbld', 21:08:01 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:01 INFO - '_': '/tools/buildbot/bin/python'} 21:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:01 INFO - Downloading/unpacking psutil>=0.7.1 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:08:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:03 INFO - Installing collected packages: psutil 21:08:03 INFO - Running setup.py install for psutil 21:08:03 INFO - building 'psutil._psutil_linux' extension 21:08:03 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 21:08:03 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 21:08:03 INFO - building 'psutil._psutil_posix' extension 21:08:03 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 21:08:03 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 21:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:03 INFO - Successfully installed psutil 21:08:03 INFO - Cleaning up... 21:08:03 INFO - Return code: 0 21:08:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:08:03 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')]} 21:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:03 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')]} 21:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:03 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:03 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 21:08:03 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 21:08:03 INFO - Using env: {'DISPLAY': ':0', 21:08:03 INFO - 'HOME': '/home/cltbld', 21:08:03 INFO - 'LANG': 'en_US.UTF-8', 21:08:03 INFO - 'LANGUAGE': 'en_US:en', 21:08:03 INFO - 'LOGNAME': 'cltbld', 21:08:03 INFO - 'MAIL': '/var/mail/cltbld', 21:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:03 INFO - 'MOZ_NO_REMOTE': '1', 21:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:03 INFO - 'NO_EM_RESTART': '1', 21:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:03 INFO - 'PWD': '/builds/slave/test', 21:08:03 INFO - 'SHELL': '/bin/bash', 21:08:03 INFO - 'SHLVL': '1', 21:08:03 INFO - 'TERM': 'linux', 21:08:03 INFO - 'TMOUT': '86400', 21:08:03 INFO - 'USER': 'cltbld', 21:08:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:03 INFO - '_': '/tools/buildbot/bin/python'} 21:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:08:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:08:05 INFO - Installing collected packages: mozsystemmonitor 21:08:05 INFO - Running setup.py install for mozsystemmonitor 21:08:05 INFO - Successfully installed mozsystemmonitor 21:08:05 INFO - Cleaning up... 21:08:05 INFO - Return code: 0 21:08:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:08:05 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')]} 21:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:05 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')]} 21:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:05 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:05 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 21:08:05 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 21:08:05 INFO - Using env: {'DISPLAY': ':0', 21:08:05 INFO - 'HOME': '/home/cltbld', 21:08:05 INFO - 'LANG': 'en_US.UTF-8', 21:08:05 INFO - 'LANGUAGE': 'en_US:en', 21:08:05 INFO - 'LOGNAME': 'cltbld', 21:08:05 INFO - 'MAIL': '/var/mail/cltbld', 21:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:05 INFO - 'MOZ_NO_REMOTE': '1', 21:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:05 INFO - 'NO_EM_RESTART': '1', 21:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:05 INFO - 'PWD': '/builds/slave/test', 21:08:05 INFO - 'SHELL': '/bin/bash', 21:08:05 INFO - 'SHLVL': '1', 21:08:05 INFO - 'TERM': 'linux', 21:08:05 INFO - 'TMOUT': '86400', 21:08:05 INFO - 'USER': 'cltbld', 21:08:05 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:05 INFO - '_': '/tools/buildbot/bin/python'} 21:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:08:05 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 21:08:05 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 21:08:05 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 21:08:05 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 21:08:05 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 21:08:05 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 21:08:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:08:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:08:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:08:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:08 INFO - Downloading docopt-0.6.1.tar.gz 21:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:08:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:08:08 INFO - Running setup.py install for blobuploader 21:08:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:08:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:08:08 INFO - Running setup.py install for requests 21:08:08 INFO - Running setup.py install for docopt 21:08:08 INFO - Successfully installed blobuploader requests docopt 21:08:08 INFO - Cleaning up... 21:08:08 INFO - Return code: 0 21:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:08 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:08 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 21:08:08 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 21:08:08 INFO - Using env: {'DISPLAY': ':0', 21:08:08 INFO - 'HOME': '/home/cltbld', 21:08:08 INFO - 'LANG': 'en_US.UTF-8', 21:08:08 INFO - 'LANGUAGE': 'en_US:en', 21:08:08 INFO - 'LOGNAME': 'cltbld', 21:08:08 INFO - 'MAIL': '/var/mail/cltbld', 21:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:08 INFO - 'MOZ_NO_REMOTE': '1', 21:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:08 INFO - 'NO_EM_RESTART': '1', 21:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:08 INFO - 'PWD': '/builds/slave/test', 21:08:08 INFO - 'SHELL': '/bin/bash', 21:08:08 INFO - 'SHLVL': '1', 21:08:08 INFO - 'TERM': 'linux', 21:08:08 INFO - 'TMOUT': '86400', 21:08:08 INFO - 'USER': 'cltbld', 21:08:08 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:08 INFO - '_': '/tools/buildbot/bin/python'} 21:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:09 INFO - Running setup.py (path:/tmp/pip-WYrNJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:09 INFO - Running setup.py (path:/tmp/pip-r3ngJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:09 INFO - Running setup.py (path:/tmp/pip-RKn7nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:09 INFO - Running setup.py (path:/tmp/pip-nTPb0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:09 INFO - Running setup.py (path:/tmp/pip-5n7w00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:09 INFO - Running setup.py (path:/tmp/pip-DC70La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:09 INFO - Running setup.py (path:/tmp/pip-USf5xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:09 INFO - Running setup.py (path:/tmp/pip-m2ilex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:09 INFO - Running setup.py (path:/tmp/pip-KWuHMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:09 INFO - Running setup.py (path:/tmp/pip-Vl9Pak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:09 INFO - Running setup.py (path:/tmp/pip-IB4nM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:09 INFO - Running setup.py (path:/tmp/pip-8hxI0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:09 INFO - Running setup.py (path:/tmp/pip-dUa_b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:09 INFO - Running setup.py (path:/tmp/pip-Yq5kRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:10 INFO - Running setup.py (path:/tmp/pip-fv3ws2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:10 INFO - Running setup.py (path:/tmp/pip-jZGWO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:10 INFO - Running setup.py (path:/tmp/pip-dIW0kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:08:10 INFO - Running setup.py install for manifestparser 21:08:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Running setup.py install for mozcrash 21:08:10 INFO - Running setup.py install for mozdebug 21:08:10 INFO - Running setup.py install for mozdevice 21:08:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Running setup.py install for mozfile 21:08:10 INFO - Running setup.py install for mozhttpd 21:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Running setup.py install for mozinfo 21:08:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:08:10 INFO - Running setup.py install for mozInstall 21:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Running setup.py install for mozleak 21:08:11 INFO - Running setup.py install for mozlog 21:08:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Running setup.py install for moznetwork 21:08:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Running setup.py install for mozprocess 21:08:11 INFO - Running setup.py install for mozprofile 21:08:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Running setup.py install for mozrunner 21:08:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:08:11 INFO - Running setup.py install for mozscreenshot 21:08:11 INFO - Running setup.py install for moztest 21:08:11 INFO - Running setup.py install for mozversion 21:08:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:08:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:08:12 INFO - Cleaning up... 21:08:12 INFO - Return code: 0 21:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:12 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 21:08:12 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 21:08:12 INFO - Using env: {'DISPLAY': ':0', 21:08:12 INFO - 'HOME': '/home/cltbld', 21:08:12 INFO - 'LANG': 'en_US.UTF-8', 21:08:12 INFO - 'LANGUAGE': 'en_US:en', 21:08:12 INFO - 'LOGNAME': 'cltbld', 21:08:12 INFO - 'MAIL': '/var/mail/cltbld', 21:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:12 INFO - 'MOZ_NO_REMOTE': '1', 21:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:12 INFO - 'NO_EM_RESTART': '1', 21:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:12 INFO - 'PWD': '/builds/slave/test', 21:08:12 INFO - 'SHELL': '/bin/bash', 21:08:12 INFO - 'SHLVL': '1', 21:08:12 INFO - 'TERM': 'linux', 21:08:12 INFO - 'TMOUT': '86400', 21:08:12 INFO - 'USER': 'cltbld', 21:08:12 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:12 INFO - '_': '/tools/buildbot/bin/python'} 21:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:12 INFO - Running setup.py (path:/tmp/pip-mzzHJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:12 INFO - Running setup.py (path:/tmp/pip-AoCt9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:12 INFO - Running setup.py (path:/tmp/pip-2dHYLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:12 INFO - Running setup.py (path:/tmp/pip-UZcfwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:12 INFO - Running setup.py (path:/tmp/pip-0UMbzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:12 INFO - Running setup.py (path:/tmp/pip-0AXkcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:12 INFO - Running setup.py (path:/tmp/pip-ORwDgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:12 INFO - Running setup.py (path:/tmp/pip-o9lSme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:12 INFO - Running setup.py (path:/tmp/pip-0hNoQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:12 INFO - Running setup.py (path:/tmp/pip-BZpgE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:12 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)) 21:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:12 INFO - Running setup.py (path:/tmp/pip-1kUnkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:13 INFO - Running setup.py (path:/tmp/pip-_euI3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:13 INFO - Running setup.py (path:/tmp/pip-CXzVJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:13 INFO - Running setup.py (path:/tmp/pip-qyLVn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:13 INFO - Running setup.py (path:/tmp/pip-4nMBKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:13 INFO - Running setup.py (path:/tmp/pip-DBnENU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:13 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)) 21:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:13 INFO - Running setup.py (path:/tmp/pip-EGVjfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:13 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)) 21:08:13 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)) 21:08:13 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)) 21:08:13 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)) 21:08:13 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)) 21:08:13 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)) 21:08:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:15 INFO - Downloading blessings-1.5.1.tar.gz 21:08:15 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 21:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:08:15 INFO - Installing collected packages: blessings 21:08:15 INFO - Running setup.py install for blessings 21:08:15 INFO - Successfully installed blessings 21:08:15 INFO - Cleaning up... 21:08:15 INFO - Return code: 0 21:08:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:08:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:15 INFO - Reading from file tmpfile_stdout 21:08:15 INFO - Current package versions: 21:08:15 INFO - argparse == 1.2.1 21:08:15 INFO - blessings == 1.5.1 21:08:15 INFO - blobuploader == 1.2.4 21:08:15 INFO - docopt == 0.6.1 21:08:15 INFO - manifestparser == 1.1 21:08:15 INFO - mozInstall == 1.12 21:08:15 INFO - mozcrash == 0.16 21:08:15 INFO - mozdebug == 0.1 21:08:15 INFO - mozdevice == 0.47 21:08:15 INFO - mozfile == 1.2 21:08:15 INFO - mozhttpd == 0.7 21:08:15 INFO - mozinfo == 0.9 21:08:15 INFO - mozleak == 0.1 21:08:15 INFO - mozlog == 3.1 21:08:15 INFO - moznetwork == 0.27 21:08:15 INFO - mozprocess == 0.22 21:08:15 INFO - mozprofile == 0.27 21:08:15 INFO - mozrunner == 6.11 21:08:15 INFO - mozscreenshot == 0.1 21:08:15 INFO - mozsystemmonitor == 0.0 21:08:15 INFO - moztest == 0.7 21:08:15 INFO - mozversion == 1.4 21:08:15 INFO - psutil == 3.1.1 21:08:15 INFO - requests == 1.2.3 21:08:15 INFO - wsgiref == 0.1.2 21:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:15 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:15 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 21:08:15 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 21:08:15 INFO - Using env: {'DISPLAY': ':0', 21:08:15 INFO - 'HOME': '/home/cltbld', 21:08:15 INFO - 'LANG': 'en_US.UTF-8', 21:08:15 INFO - 'LANGUAGE': 'en_US:en', 21:08:15 INFO - 'LOGNAME': 'cltbld', 21:08:15 INFO - 'MAIL': '/var/mail/cltbld', 21:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:15 INFO - 'MOZ_NO_REMOTE': '1', 21:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:15 INFO - 'NO_EM_RESTART': '1', 21:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:15 INFO - 'PWD': '/builds/slave/test', 21:08:15 INFO - 'SHELL': '/bin/bash', 21:08:15 INFO - 'SHLVL': '1', 21:08:15 INFO - 'TERM': 'linux', 21:08:15 INFO - 'TMOUT': '86400', 21:08:15 INFO - 'USER': 'cltbld', 21:08:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:15 INFO - '_': '/tools/buildbot/bin/python'} 21:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 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)) 21:08:15 INFO - Cleaning up... 21:08:15 INFO - Return code: 0 21:08:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:15 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:15 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 21:08:15 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 21:08:15 INFO - Using env: {'DISPLAY': ':0', 21:08:15 INFO - 'HOME': '/home/cltbld', 21:08:15 INFO - 'LANG': 'en_US.UTF-8', 21:08:15 INFO - 'LANGUAGE': 'en_US:en', 21:08:15 INFO - 'LOGNAME': 'cltbld', 21:08:15 INFO - 'MAIL': '/var/mail/cltbld', 21:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:15 INFO - 'MOZ_NO_REMOTE': '1', 21:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:15 INFO - 'NO_EM_RESTART': '1', 21:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:15 INFO - 'PWD': '/builds/slave/test', 21:08:15 INFO - 'SHELL': '/bin/bash', 21:08:15 INFO - 'SHLVL': '1', 21:08:15 INFO - 'TERM': 'linux', 21:08:15 INFO - 'TMOUT': '86400', 21:08:15 INFO - 'USER': 'cltbld', 21:08:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:15 INFO - '_': '/tools/buildbot/bin/python'} 21:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:16 INFO - Downloading/unpacking jsonschema 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08: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 21:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:08:17 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 21:08:17 INFO - Downloading/unpacking functools32 (from jsonschema) 21:08:17 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 21:08:17 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 21:08:17 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 21:08:17 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 21:08:17 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 21:08:17 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 21:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 21:08:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:08:17 INFO - warning: no files found matching '*.txt' 21:08:17 INFO - no previously-included directories found matching 'build' 21:08:17 INFO - no previously-included directories found matching 'dist' 21:08:17 INFO - no previously-included directories found matching '.git*' 21:08:17 INFO - Installing collected packages: jsonschema, functools32 21:08:18 INFO - Running setup.py install for functools32 21:08:18 INFO - warning: no files found matching '*.txt' 21:08:18 INFO - no previously-included directories found matching 'build' 21:08:18 INFO - no previously-included directories found matching 'dist' 21:08:18 INFO - no previously-included directories found matching '.git*' 21:08:18 INFO - Successfully installed jsonschema functools32 21:08:18 INFO - Cleaning up... 21:08:18 INFO - Return code: 0 21:08:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:08:18 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')]} 21:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:18 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')]} 21:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:18 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 0x7fef49c87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', '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 21:08:18 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 21:08:18 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 21:08:18 INFO - Using env: {'DISPLAY': ':0', 21:08:18 INFO - 'HOME': '/home/cltbld', 21:08:18 INFO - 'LANG': 'en_US.UTF-8', 21:08:18 INFO - 'LANGUAGE': 'en_US:en', 21:08:18 INFO - 'LOGNAME': 'cltbld', 21:08:18 INFO - 'MAIL': '/var/mail/cltbld', 21:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:18 INFO - 'MOZ_NO_REMOTE': '1', 21:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:18 INFO - 'NO_EM_RESTART': '1', 21:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:18 INFO - 'PWD': '/builds/slave/test', 21:08:18 INFO - 'SHELL': '/bin/bash', 21:08:18 INFO - 'SHLVL': '1', 21:08:18 INFO - 'TERM': 'linux', 21:08:18 INFO - 'TMOUT': '86400', 21:08:18 INFO - 'USER': 'cltbld', 21:08:18 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:18 INFO - '_': '/tools/buildbot/bin/python'} 21:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:18 INFO - Downloading/unpacking flake8 21:08:18 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 21:08:18 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 21:08:18 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 21:08:18 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 21:08:18 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 21:08:18 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 21:08:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:08:20 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 21:08:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:08:20 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 21:08:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 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 21:08:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:08:20 INFO - no previously-included directories found matching 'docs/_build' 21:08:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:08:20 INFO - Running setup.py install for pep8 21:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:08:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:08:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:08:20 INFO - no previously-included directories found matching 'docs/_build' 21:08:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:08:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:08:20 INFO - Cleaning up... 21:08:20 INFO - Return code: 0 21:08:20 INFO - Running post-action listener: _resource_record_post_action 21:08:20 INFO - Running post-action listener: _start_resource_monitoring 21:08:20 INFO - Starting resource monitoring. 21:08:20 INFO - ##### 21:08:20 INFO - ##### Running install step. 21:08:20 INFO - ##### 21:08:20 INFO - Running pre-action listener: _resource_record_pre_action 21:08:20 INFO - Running main action method: install 21:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:21 INFO - Reading from file tmpfile_stdout 21:08:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:08:21 INFO - Reading from file tmpfile_stdout 21:08:21 INFO - Output received: 21:08:21 INFO - Usage: mozinstall [options] installer 21:08:21 INFO - Options: 21:08:21 INFO - -h, --help show this help message and exit 21:08:21 INFO - -d DEST, --destination=DEST 21:08:21 INFO - Directory to install application into. [default: 21:08:21 INFO - "/builds/slave/test"] 21:08:21 INFO - --app=APP Application being installed. [default: firefox] 21:08:21 INFO - mkdir: /builds/slave/test/build/application 21:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:08:35 INFO - Reading from file tmpfile_stdout 21:08:35 INFO - Output received: 21:08:35 INFO - /builds/slave/test/build/application/firefox/firefox 21:08:35 INFO - Running post-action listener: _resource_record_post_action 21:08:35 INFO - ##### 21:08:35 INFO - ##### Running run-tests step. 21:08:35 INFO - ##### 21:08:35 INFO - Running pre-action listener: _resource_record_pre_action 21:08:35 INFO - Running main action method: run_tests 21:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:08:35 INFO - Python 2.7.3 21:08:35 INFO - Return code: 0 21:08:35 INFO - grabbing minidump binary from tooltool 21:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:35 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 0x1dd70b0>, '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 0x1dd7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:08:35 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 21:08:35 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 21:08:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:08:35 INFO - Return code: 0 21:08:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:08:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:08:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:08:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:08:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:08:36 INFO - Return code: 0 21:08:36 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/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 21:08:36 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/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 21:08:36 INFO - Using env: {'DISPLAY': ':0', 21:08:36 INFO - 'HOME': '/home/cltbld', 21:08:36 INFO - 'LANG': 'en_US.UTF-8', 21:08:36 INFO - 'LANGUAGE': 'en_US:en', 21:08:36 INFO - 'LOGNAME': 'cltbld', 21:08:36 INFO - 'MAIL': '/var/mail/cltbld', 21:08:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:08:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:36 INFO - 'MOZ_NO_REMOTE': '1', 21:08:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:36 INFO - 'NO_EM_RESTART': '1', 21:08:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:36 INFO - 'PWD': '/builds/slave/test', 21:08:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:08:36 INFO - 'SHELL': '/bin/bash', 21:08:36 INFO - 'SHLVL': '1', 21:08:36 INFO - 'TERM': 'linux', 21:08:36 INFO - 'TMOUT': '86400', 21:08:36 INFO - 'USER': 'cltbld', 21:08:36 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209', 21:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:36 INFO - '_': '/tools/buildbot/bin/python'} 21:08:36 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/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 21:08:36 INFO - mozversion INFO | application_buildid: 20151216194533 21:08:36 INFO - mozversion INFO | application_changeset: 77ab820ce477438af4b32cea83f82fd55744cec7 21:08:36 INFO - mozversion INFO | application_display_name: Nightly 21:08:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:08:36 INFO - mozversion INFO | application_name: Firefox 21:08:36 INFO - mozversion INFO | application_remotingname: firefox 21:08:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 21:08:36 INFO - mozversion INFO | application_vendor: Mozilla 21:08:36 INFO - mozversion INFO | application_version: 46.0a1 21:08:36 INFO - mozversion INFO | platform_buildid: 20151216194533 21:08:36 INFO - mozversion INFO | platform_changeset: 77ab820ce477438af4b32cea83f82fd55744cec7 21:08:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 21:08:36 INFO - mozversion INFO | platform_version: 46.0a1 21:08:36 INFO - 2015-12-16 21:08:36,989 DEBUG : using testdate: 1450328916 21:08:36 INFO - 2015-12-16 21:08:36,989 DEBUG : actual date: 1450328916 21:08:37 INFO - 2015-12-16 21:08:37,036 INFO : starting webserver on 'localhost:47944' 21:08:37 INFO - 2015-12-16 21:08:37,037 INFO : Starting test suite talos-linux64-ix-035 21:08:37 INFO - 2015-12-16 21:08:37,037 INFO : Starting test dromaeo_css 21:08:37 INFO - 2015-12-16 21:08:37,038 DEBUG : operating with platform_type : linux_ 21:08:37 INFO - 2015-12-16 21:08:37,038 INFO : Initialising browser for dromaeo_css test... 21:08:37 INFO - 2015-12-16 21:08:37,050 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kKxvH/profile http://localhost:47944/getInfo.html 21:08:41 INFO - 2015-12-16 21:08:41,085 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:08:41 INFO - 2015-12-16 21:08:41,086 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:08:41 INFO - 2015-12-16 21:08:41,086 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:08:41 INFO - 2015-12-16 21:08:41,086 DEBUG : BROWSER_OUTPUT: __metrics 21:08:41 INFO - 2015-12-16 21:08:41,235 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] 21:08:41 INFO - 2015-12-16 21:08:41,298 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] 21:08:42 INFO - 2015-12-16 21:08:42,520 INFO : Browser initialized. 21:08:42 INFO - 2015-12-16 21:08:42,520 INFO : Running cycle 1/1 for dromaeo_css test... 21:08:42 INFO - 2015-12-16 21:08:42,521 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6kKxvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:08:54 INFO - 2015-12-16 21:08:54,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 142270464 21:08:54 INFO - 2015-12-16 21:08:54,529 DEBUG : BROWSER_OUTPUT: 21:09:45 INFO - 2015-12-16 21:09:45,873 DEBUG : BROWSER_OUTPUT: 1450328985872 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] 21:11:57 INFO - 2015-12-16 21:11:57,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47944/tests/dromaeo/cssquery-ext.html) 21:11:58 INFO - 2015-12-16 21:11:58,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 221179904 21:11:58 INFO - 2015-12-16 21:11:58,847 DEBUG : BROWSER_OUTPUT: 21:15:01 INFO - 2015-12-16 21:15:01,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-ext.html (next: http://localhost:47944/tests/dromaeo/cssquery-jquery.html) 21:15:01 INFO - 2015-12-16 21:15:01,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 223567872 21:15:01 INFO - 2015-12-16 21:15:01,935 DEBUG : BROWSER_OUTPUT: 21:18:03 INFO - 2015-12-16 21:18:03,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47944/tests/dromaeo/cssquery-mootools.html) 21:18:04 INFO - 2015-12-16 21:18:04,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 213270528 21:18:04 INFO - 2015-12-16 21:18:04,561 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-12-16 21:21:06,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47944/tests/dromaeo/cssquery-prototype.html) 21:21:07 INFO - 2015-12-16 21:21:07,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 202113024 21:21:07 INFO - 2015-12-16 21:21:07,146 DEBUG : BROWSER_OUTPUT: 21:24:09 INFO - 2015-12-16 21:24:09,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47944/tests/dromaeo/cssquery-yui.html) 21:24:10 INFO - 2015-12-16 21:24:10,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 202563584 21:24:10 INFO - 2015-12-16 21:24:10,579 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/dromaeo/cssquery-yui.html (next: http://localhost:47944/tests/dromaeo/cssquery-dojo.html) 21:27:13 INFO - 2015-12-16 21:27:13,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 261644288 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:27:13 INFO - 2015-12-16 21:27:13,316 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2639.947201055979;2734.179746076177;2734.2890848379416;2746.299693578137;2751.7248275172487;4562.817487300504;4697.389339385883;4748.382710247667;4768.427788665365;4787.712737235768;4719.952800471994;4730.053989202164;4838.371011768474;4842.201036828919;4866.416030076387;4300.505441874193;4334.371516130159;4368.388425620416;4421.88945276369;4424.756638384888;4412.0955204183065;4515.954840451603;4531.592156705896;4534.501204867462;4543.681942264043;4174.645155161815;4278.336857787048;4290.721103128287;4466.82132714691;4516.480604730433;4206.831726730927;4303.35449682547;4305.870823875289;4306.20335237982;4318.935215971763;4374.540673229297;4381.890452738675;4390.143921935224;4396.3614941438655;4417.602415782563;4429.911401771947;4656.837010704643;4696.671233013691;4711.646626502992;4735.242361222188;4947.975260123676;4969.925451118236;5045.5459008689395;5128.358955130609;5165.845024649267;5124;5148.742562871841;5152.562032227265;5156.484351564851;5156.742162891878;4554.20301447252;4766.404199475066;4776.761161941889;4777.713337199744;4821.710697358135;5134.922976155361;5154.407243167008;5158.587313014949;5228.9738551307;5238.528532432099;4996.475370086088;4998.4251811042195;5002.074616196015;5006.023825354094;5046.823361182341;4846.975765121152;5083.2375143727995;5085.796568137233;5088.949110508922;5104.69371837691;4934.333864928189;4940.802367905244;4963.255511673278;4964.553190212898;5058.54473097423;5056.519630635084;5073.34046573943;5076.035553244946;5079.796808127633;5084.415292241366;4258.5954334338185;4262.42457268271;4271.9786401067795;4304.053108316165;4307.569243075667;3571.571411430593;3659.3779057559746;3682.208325210093;3690.760100593453;3756.887293381203;4329.610335069859;4385.978070109692;4387.517373088957;4391.8682439526865;4427.623651989553;5075.2387141929;5113.309703190096;5157.63896527247;5164.92252616211;5205.583553315726;4221.303484925014;4350.303951367766;4416.447944006999;4422.181896349186;4472.686911916135;4430.601245887886;4442.933355999598;4453.042595841909;4478.865634030984;4515.503294637587;4833.299171620166;4837.298591704112;4839.733814640229;4840.8789780254365;4874.561289483963;4836.733979631013;4941.6293777966075;5074.086664400444;5077.8730531737;5131.281620573048;4700.529947005272;4776.522347765195;4821.590164836029;4835.492273311252;4839.637027222902;5019.52314530119;5056.418511871182;5065.417476990193;5070.746462676925;5110.437851836369;5130.48695130484;5132.178851383761;5139.922901156411;5142.717150556755;5184.844454666366;4667.696599721143;4723.291506274087;4780.928286075781;4857.684250523705;4977.502249774993;4912.066707325596;4931.48219436954;4931.827386041471;4938.506149385033;4983.053219888209;4828.686135401188;4840.177169881199;4848.466668666514;4851.248056551241;4877.195262781602;4705.364775755366;4792.448868380181;4862.319275301531;4864.124457597666;4920.950790492049;4807.302941073594;4819.204831202953;4824.469308376146;4828.444728856227;4874.95125048745 21:27:13 INFO - 2015-12-16 21:27:13,318 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8510002299377;556.3212880286052;569.843293094399;573.787698551536;579.0908274009804;26102.86948565257;26716.465670686597;34440.31119377614;34844.82577587115;34889;38541;38920.416193757046;39051.41422878652;39062.41406378907;39217;6913.861722765541;7796.766097017085;7959.403044771636;7970.123286438487;7970.322522585587;7034.155901291852;7117.964410177942;7122.964385178067;7130.643467826614;9439.764005899839;9608.615655373776;9703.563339649732;9705.75735606612;9713.757156071084;9717.562709678046;9843.26175536834;9990.500474976223;9991.90008099917;9997.250206234525;10002.299839011272;7101.041359416516;7289.088863892013;9672.951635241849;9921.206303495703;9923.503824808802;33387.16532086693;33872;33891.661083389095;33904.49143262853;33910.83044584761;2939.544370622557;3649.6532829381167;3678.7608805427562;3744.812759362021;3757.4927384802977;27217;27524.724752752416;27581.172564823086;27985.020524281757;28448;3288.96711032889;3306.7354611631013;3329.334133173375;3362.142653623335;3413.4026545354714;211329;211342;211343;211447;275541;41273;57238.7138064307;59039.40960590339;59051;59078.40921590815;51350.74324628353;51634.48365516372;51682.48317516777;51777.7411112942;51790.741046294526;13266.867331326755;13595.592132236048;13603.659908502366;13604.047716659938;13606.387712552762;10205.897941020643;10462.267641265038;10466.947665261625;10471.633492827867;10476.161907047417;17619.911900440417;17857.732134018;17858.91070544639;17887.642247155243;17906.28374865017;6958.130233720785;7011.789646310517;7051.1891132519395;7086.893696594555;7203.747868824566;827.7227128911882;907.9863802042843;1052.8631277933819;1061.6602687140196;1080.0549519170725;26210.73789262083;26283.737162628127;26440.73559264421;26613.600795988077;26689.3327666806;981.8120074709539;1006.3207335048813;1014.6347314966606;1042.838360054193;1110.1119104716195;13908;13932.233727145105;14440.350184241734;14638.487652932095;14685.632859178606;261627;265804;266035;266411;266713;45928.77035614867;45995.77002114968;46176.7691161542;46223.07553848904;46232.3065154023;1222.6637674639367;1222.9082818788627;1246.307974774501;1247.6818411305242;1253.2104773992326;25346.239612811645;25946.74053259443;26045;26358.868205658848;26381.736182638695;38730.22539549137;38974.220515590096;39089.218215636094;39095;39141.41287880627;241858;243700;243900;244433;245284;24087;24364.63453048241;27263.318417039733;27304.044358447358;28322.575161372184;33154.834225828716;33327.666723332455;33534.16164595807;33551.81257780507;33778.8311058453;30836.84581577078;31246.18784309423;31709.048728538182;32269;32464.188395289362;26294.60558091592;29960;31607.525887111253;31911.042668719976;32165.517517236793;28959.13122606325;29372.412551749272;29532.409351813272;29565.556516652698;29598.260043499085;24381.51236975286;28684.85657571699;29501.26246843846;29602.891696372433;29647.25881852971;22923.31230063101;22953.540929181658;23015.654765178202;23040.4239894004;23275.650865237374 21:27:13 INFO - 2015-12-16 21:27:13,321 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.43478955355;336.5591075690845;338.7916431394693;338.9237421580145;341.79150718061993;12478.438470268837;12846.48614055439;14894.47869324574;15030.473933412333;15568.455104071345;12577.496900123984;14600.780988285183;14710.043847149955;14896.25518724065;14909.478168264113;4282.122164956177;4428.136513379876;4922.999999999991;4961.131801934665;5064.898702025957;3680.8527658893613;3784.12965018046;3786.924261514768;3788.2234142000825;4939.407271127452;3763.5671897731836;3771.66055055045;5599.41206173352;5722.456366645183;5766.0486019806685;5553;5643.915341269884;5677.574181936371;5677.886442271173;5719.142128680711;4953.752312384367;4957.479464656195;4958.677685950402;4960.2063669813015;4987.376577927759;17709.645807083914;18256.452306430827;18338.90830545852;18344;19293.131809068625;1863.683173860447;1867.8599105067174;1876.136976990586;1939.5054261163455;2005.8495612828951;12371.505139794397;12532.122751407405;12790.424430900539;12873.356332183354;12892.162009469355;1737.444017914268;1739.5738044179257;1744.345870298638;1763.8765286429955;1773.1666116925026;49441;50431.74784126093;50594.241086383736;50967.490325096645;51166.48833511692;9015.684451044182;9349.53252337394;9498.90501094994;9663.46850923192;9730.270229732656;12448.688782780502;12451.315177665316;12475.376231188404;12475.812862807064;12500.562480313145;6657.833554161088;6700.128983232246;6701.1623547056615;6739.5619284746335;6767.52627316093;6149.96925015372;6158.322584515699;6209.441150296495;6211.3167551569295;6221.844453888599;4038.737482063715;4104.958950410517;4113.691473139466;4154.169166166779;4156.605122513356;1575.7951466309307;1618.409280612568;1625.6992456395606;1661.2275291989283;1732.3936622182387;761.2159475739996;772.9536227826236;811.2779626132747;832.6086739232551;927.420362273579;15118.924405377902;15647.921760391126;15866.206689665702;15961.760573591406;16153;731.3564063623977;793.1909452358677;805.5166899860154;813.9267465928095;833.8957630296213;7869.960650196713;8362.623681934327;8471.195236452528;8604.48373097616;8851.955740221258;319908;322012;323177;324408;471663;51372.74313628483;59804.40195597988;61030.33817970936;61605.691971539854;62701.68649156725;1052.5684469367675;1057.5716834681966;1077.42357838556;1110.4503270880805;1110.4558766204502;13587;13596.348712001065;14335.784963225351;14421;14487.275636218357;32303;32543.674563254066;32971;33194.336113278085;33473.163170920925;39308.6069139305;39676.40485392664;40647.1870562593;41351.37972930469;41444;8298.958505207434;8773.42972706772;8842.071582484004;8844.115588441104;9013;10224.846627300447;10238.846417303896;10303.278770486293;12578.30819304947;15806.525804225892;13138.73722525525;13353.265570393332;13516.729665406834;13542.187468751907;13609;12724.491020359452;12807.551735689207;12874.806877896652;13293.401796919356;13404;14144.575662730134;14147.504837330644;14198.361073751912;14248.572542823731;14316.57050288493;8877.73366798997;8893;8902.910970890209;8922.73231803047;9168.44989300644;13818.309084545934;13910.721785564434;13939.930300348433;13988.370523326272;14042.719145617235 21:27:13 INFO - 2015-12-16 21:27:13,321 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1075.1022895881938;1153.873073961864;1234.9197302175353;1619.1013987237081;1697.9660406791868;6013.368596297391;6992.965035174823;7177.641117944095;7198.424126069908;7209.855802883939;6884.414824739891;6974.96512517438;7015.684294206761;7019.052427922242;7020.648967551615;1733.0035229742884;1766.293482606961;2038.7859274776158;2072.82380997615;2102.316747057205;2081.3131666550003;2091.2366986050133;2091.351680978894;2092.4245832396136;2092.7593326767465;1987.9403617891414;2009.8392128629675;2059.979400205994;2060.248009476538;2061.8556701030934;2040.1431398812535;2055.4142069510194;2064.298138632872;2094.52873103552;2095.8952052397394;2051.6204502166997;2073.284716772711;2074.761402438724;2080.771115177329;2081.9687704684443;7123.857522849566;7190.352868241831;7191.424686025158;7194;7194.7122115115335;4084.509858816961;4167.083241686824;4167.312393455076;4176.749395036308;4184.205001049791;2630.8289961152464;2698.3016983016983;2737.54830452975;2749.024096445753;2763.69599344072;857.8327226190895;873.2708188662474;877.8727084572765;883.650957871637;889.8843150390472;9355.812883742356;9573.234141268682;9579.521023948844;9581.712548623553;9593.760155996017;3908.179282350681;3960.405939109099;4058.350663893763;4081.5306239782803;4119.258533463945;8407.453515521594;8462.534560599102;8479.872801907977;8493.44792588492;8502.192291732275;4342.131573685276;4403.625691816232;4415.227335216325;4426.867193984185;4430.424044874146;3983.741056831355;4020.979895100564;4022.718409711292;4023.7183397162503;4028.617281358266;3086.66046734859;3147.669494703069;3398.405279076201;3409.1647546350805;3462.4633181856852;1128.2666266926399;1145.5818626201376;1148.1962626161553;1149.528693235786;1150.9769804603861;1139.1968662093204;1175.9706007349714;1214.908881833866;1218.421249906305;1218.7867123253395;6598;6705.731770729214;6736.797896063126;6737.9663101685155;6770.72917083321;584.4593750780596;592.026117037471;594.147398483178;594.1948659566311;742.0835268443468;5308.177232528964;5325.961437519646;5328.626996110235;5338.572914166857;5378.058839703036;8109.432339736162;8504.489730616182;8584.098669639598;8587.527685977206;8594.828103437896;8522.232999030117;8571.95714021426;8600.311975042106;8604.526751028754;8605.483670979762;6706.765263215764;6742.730290788313;6820.283870193657;6838.794836154824;6867.725290988405;6451;6481.643509607017;6482.448991835747;6493.058506516623;6498.415142637185;7574.394048476219;7810.921890781019;7821.882671759814;7829.29536341732;7831.451798374059;7666.769996900102;7974.362051036019;7976;8099.514029158034;8106.635201416068;6006.15913772081;6119.388061193845;6156.876862462816;6164.938350616437;6186.628802271878;5814.709264536672;6032.1856549365275;6492.513061520499;6626.6686665667485;6641.937290033571;6458.61248325102;6522.249941256627;6582.868342633216;6603.966980165068;6630.071789949315;6281.937180628135;6300.21247344082;6303.338149494421;6367.777127800505;6386.457151142019;6354.968225158845;6402.551821372459;6413.679316034273;6414.10202571631;6418.711157997995;6084.33072362031;6123.112148738497;6128;6128.203333566787;6130.601510901777;5897.174395584536;5951.940480595139;5985.191999080069;6005.459508644243;6164.630122192682 21:27:13 INFO - 2015-12-16 21:27:13,323 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.8574798348809;299.28918817807704;304.108960745017;311.2312587907867;313.46241196348257;5296.152615581503;5314;5389.892202155965;5400.891982160354;5413.188021796733;5281.392639846419;5315.574754019679;5318.521333080022;5329.040772660929;5330;3953.446517487554;4179.6029377209115;4182.97908510457;4186.079062606222;4191.5179754328265;4031.3146765049864;4063.207674503473;4143.129942712034;4164.541900390955;4169.061961058753;4096.774677392757;4114.567970363114;4117.402976568395;4118.423420721101;4127.752334859903;3912.6087391260644;4018.8794336169963;4021.1153546219784;4120.526139493952;4124.525679546846;3652.397354436515;3654.2326111516613;3659.249853779969;3667.6149004354693;3681.1901381695984;5107.7446127693465;5114.514121158484;5117.6161787865685;5119.129747942859;5131.692098474104;4737.313089602023;4739.715617062952;4740.928886066712;4744.501827308118;4747.667663263573;5455.509004189642;5573.359063707685;5577.69322687252;5580.609357344987;5596.776128954837;3960.1089754805225;3960.940585891214;3967.02807812085;3968.940465893014;3977;5878.118282257653;5878.735456904406;5880.529557635379;5883.499902508292;5887.116932460122;4091.5294741105154;4093.16090201508;4093.5087789465456;4093.672506199497;4095.1400205957084;3733.328000959799;3785.413260944558;4157.812898419578;4163.604457576525;4164.042270277853;4488.618467430305;4576.8626941191815;4581.450225972904;4587.9541204588195;4596.770161491979;5439.891202175934;5447.945520544823;5500.724963751796;5581.5255703265675;5594.916076258859;1380.827396575428;1414.0667159674565;1415.9804940442864;1416.3343228682502;1420.7158568286384;925.9120383563551;943.8914524829595;954.5895265036102;957.2581249531529;959.4243453927587;4854.878628034327;4875.634327425457;4883.4628190898975;4885.511448855157;4886.975565122151;5726.455986681259;5727.4845263926445;5745.6552606843725;5753.62601430914;5761.798337058183;4843.539863712942;4860.198067318924;4871.610271178297;4872.878178045577;4874.341963834837;2895.739383455457;2954.615899933038;3068.4936985397158;3076.430860290853;3095.086949349947;5432.511074003359;5548.278723765885;5550.750216240198;5553.444655534495;5556.277683901067;6015.037593984942;6016.488598469179;6017.187679663277;6019.488343490765;6019.518438524908;5541.9168712469345;5546.77812887488;5553.611247212656;5555.611107222537;5557.194206840067;5723;5813.56398270123;5839.708014599168;5850.707464626837;5859.58982871212;5651.802186923438;5702.800401985911;5705.030144875298;5708;5714.000049991318;5516.862078448071;5520.972395137998;5529;5530.474604912527;5535.39110697831;3993.440918271386;4001.1797581495143;4004.599540045972;4004.8798536043964;4006.238814625212;5673.347565030074;5830.5044071254415;5833.416658334133;5834.912476312774;5835.241418615553;5574.77700891976;5577;5577.298923828109;5578.414266501959;5580.2466666999435;5607.971960140173;5611.354694210055;5614.494695477427;5614.550835933034;5619.971900140473;5354.54486368663;5480.890382192413;5487.341519017744;5488.1767734838495;5488.451154884479;5592.692401917933;5600.0759874620235;5602.663840169603;5650.208970744181;5654.745536450787;5289.920651190158;5387.299651045339;5450.836474905759;5460.290162278879;5528.336599608073 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: |5;yui.html;628.4658040665435;630.5869655375731;653.1280740211816;715.7423327602062;728.3626826526789;11900.285982841036;12082.33547154906;12235.143539952218;12269.754604907897;12275.631731048072;10222.642207522738;11808.291502509834;11891.345975971319;11933.940330298336;11962.342071186082;632.2065807411703;801.4029547986729;817.9222973817508;819.2749416766175;819.4632515702225;804.90341159061;812.5165526511746;817.4278005396217;817.435969181266;817.750586071248;667.2426795586995;675.8715843989626;833.2251006563893;835.2649668291895;835.7994081420446;829.5478963964623;844.3582877013514;844.6452489954233;844.8014716541577;845.247729520727;635.7202830754453;635.8823617630753;635.8887194740902;636.5798572941883;637.4995628431706;11625.186236963416;11877.346745928971;11887.643370698894;11907.821382679267;11933.641990740292;10764.354138751622;11053.894610538962;11146.888531114666;11395.829062564067;11506.94246528762;8881.777955551162;8962.283017358595;8969.551522423919;9279.582418791104;9378.015308392589;3144.8584813683437;3151.416987857254;3166.8118122080723;3173.666764989666;3221.887233946824;39088.21823563541;39162.60837391647;39176.41235381472;39316.80341598274;39332;8981.910180898238;9003.234725048313;9033.322500812465;9038.231750301298;9218.907810921804;15611.375544978073;15636.530904072668;15676.05943643385;15690.76463853043;15787.28957196929;6034.465623819834;6144.662043587646;6162.630242185393;6178.042403427476;6180.351063138396;3365.4278772608714;3382.5771778527683;3383.5601371821504;3492.5459690240614;3522.295540891832;2467.8889449974795;2497.8126640502037;2509.2723110298175;2510.79913606911;2516.27028161831;460.7028466638999;464.4937018649688;472.04882162442703;472.5723220485466;475.62188060491303;486.7079752148753;537.3498067338564;563.6646195513663;590.2533295381346;592.3070008090544;7369.410447164214;7392.371648409838;7487.550746955091;7501.399888008947;7773.106092799288;457.47162027857877;513.599392473871;567.4439049731286;580.1848402993801;614.2598169206096;3656.3966945453703;3715.0898029982827;3720.869769558107;3743.7753734775456;3821.617838216156;48313;48373.75813120982;48611;48621;49385.50614493881;43236;43497.78251108724;43505.56494435079;43537.56462435398;43574.7821260898;38225.808870955465;39208.41187382192;39572.60427395747;39601.40597891034;39846;7187.712491500281;7286.234945330664;7335.156457007299;7375.262473752582;7511.51175173612;29991.550126748552;30082.548761768154;30300.54549181808;30534.694653054074;30575;36950.63049369472;37220.62779372172;38056.61943380531;40483.79758101308;40492.797536012135;9084.682036128705;9539.427634341962;9615;9755.365901216683;9765.218782497524;10022.498875056364;10140.645077422254;10506.264561480622;10581.788364232827;10737.409442480739;9553.331266811534;9787.21702263803;9828.852567211641;9861.802763944537;10130.797384052425;9795.167410770164;9918.256130790076;10181.541830617492;10238.9761023897;10250.38497690141;9672.613095476103;9703.12671859536;10044.547995340374;10194.235432342455;10227.48862556884;8310.91744667334;8452.154784521745;8635.920509936257;8692.33286072639;8750.256228220673;7722.498037627536;8357.247847693738;8430.578471076544;8477.338447626387;8555.187257210555 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: __startTimestamp1450330033311__endTimestamp 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:27:13 INFO - 2015-12-16 21:27:13,324 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:27:13 INFO - 2015-12-16 21:27:13,325 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,325 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4679.92 Median:4824.47 stddev:488.76 (10.1%) stddev-sans-first:463.32 21:27:13 INFO - 2015-12-16 21:27:13,326 DEBUG : BROWSER_OUTPUT: Values: 2639.9 2734.2 2734.3 2746.3 2751.7 4562.8 4697.4 4748.4 4768.4 4787.7 4720.0 4730.1 4838.4 4842.2 4866.4 4300.5 4334.4 4368.4 4421.9 4424.8 4412.1 4516.0 4531.6 4534.5 4543.7 4174.6 4278.3 4290.7 4466.8 4516.5 4206.8 4303.4 4305.9 4306.2 4318.9 4374.5 4381.9 4390.1 4396.4 4417.6 4429.9 4656.8 4696.7 4711.6 4735.2 4948.0 4969.9 5045.5 5128.4 5165.8 5124.0 5148.7 5152.6 5156.5 5156.7 4554.2 4766.4 4776.8 4777.7 4821.7 5134.9 5154.4 5158.6 5229.0 5238.5 4996.5 4998.4 5002.1 5006.0 5046.8 4847.0 5083.2 5085.8 5088.9 5104.7 4934.3 4940.8 4963.3 4964.6 5058.5 5056.5 5073.3 5076.0 5079.8 5084.4 4258.6 4262.4 4272.0 4304.1 4307.6 3571.6 3659.4 3682.2 3690.8 3756.9 4329.6 4386.0 4387.5 4391.9 4427.6 5075.2 5113.3 5157.6 5164.9 5205.6 4221.3 4350.3 4416.4 4422.2 4472.7 4430.6 4442.9 4453.0 4478.9 4515.5 4833.3 4837.3 4839.7 4840.9 4874.6 4836.7 4941.6 5074.1 5077.9 5131.3 4700.5 4776.5 4821.6 4835.5 4839.6 5019.5 5056.4 5065.4 5070.7 5110.4 5130.5 5132.2 5139.9 5142.7 5184.8 4667.7 4723.3 4780.9 4857.7 4977.5 4912.1 4931.5 4931.8 4938.5 4983.1 4828.7 4840.2 4848.5 4851.2 4877.2 4705.4 4792.4 4862.3 4864.1 4921.0 4807.3 4819.2 4824.5 4828.4 4875.0 21:27:13 INFO - 2015-12-16 21:27:13,326 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,326 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39718.48 Median:31658.29 stddev:63955.54 (202.0%) stddev-sans-first:64067.34 21:27:13 INFO - 2015-12-16 21:27:13,326 DEBUG : BROWSER_OUTPUT: Values: 551.9 556.3 569.8 573.8 579.1 26102.9 26716.5 34440.3 34844.8 34889.0 38541.0 38920.4 39051.4 39062.4 39217.0 6913.9 7796.8 7959.4 7970.1 7970.3 7034.2 7118.0 7123.0 7130.6 9439.8 9608.6 9703.6 9705.8 9713.8 9717.6 9843.3 9990.5 9991.9 9997.3 10002.3 7101.0 7289.1 9673.0 9921.2 9923.5 33387.2 33872.0 33891.7 33904.5 33910.8 2939.5 3649.7 3678.8 3744.8 3757.5 27217.0 27524.7 27581.2 27985.0 28448.0 3289.0 3306.7 3329.3 3362.1 3413.4 211329.0 211342.0 211343.0 211447.0 275541.0 41273.0 57238.7 59039.4 59051.0 59078.4 51350.7 51634.5 51682.5 51777.7 51790.7 13266.9 13595.6 13603.7 13604.0 13606.4 10205.9 10462.3 10466.9 10471.6 10476.2 17619.9 17857.7 17858.9 17887.6 17906.3 6958.1 7011.8 7051.2 7086.9 7203.7 827.7 908.0 1052.9 1061.7 1080.1 26210.7 26283.7 26440.7 26613.6 26689.3 981.8 1006.3 1014.6 1042.8 1110.1 13908.0 13932.2 14440.4 14638.5 14685.6 261627.0 265804.0 266035.0 266411.0 266713.0 45928.8 45995.8 46176.8 46223.1 46232.3 1222.7 1222.9 1246.3 1247.7 1253.2 25346.2 25946.7 26045.0 26358.9 26381.7 38730.2 38974.2 39089.2 39095.0 39141.4 241858.0 243700.0 243900.0 244433.0 245284.0 24087.0 24364.6 27263.3 27304.0 28322.6 33154.8 33327.7 33534.2 33551.8 33778.8 30836.8 31246.2 31709.0 32269.0 32464.2 26294.6 29960.0 31607.5 31911.0 32165.5 28959.1 29372.4 29532.4 29565.6 29598.3 24381.5 28684.9 29501.3 29602.9 29647.3 22923.3 22953.5 23015.7 23040.4 23275.7 21:27:13 INFO - 2015-12-16 21:27:13,326 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,327 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21916.16 Median:337.68 stddev:58401.68 (17295.2%) stddev-sans-first:58543.03 21:27:13 INFO - 2015-12-16 21:27:13,327 DEBUG : BROWSER_OUTPUT: Values: 336.4 336.6 338.8 338.9 341.8 12478.4 12846.5 14894.5 15030.5 15568.5 12577.5 14600.8 14710.0 14896.3 14909.5 4282.1 4428.1 4923.0 4961.1 5064.9 3680.9 3784.1 3786.9 3788.2 4939.4 3763.6 3771.7 5599.4 5722.5 5766.0 5553.0 5643.9 5677.6 5677.9 5719.1 4953.8 4957.5 4958.7 4960.2 4987.4 17709.6 18256.5 18338.9 18344.0 19293.1 1863.7 1867.9 1876.1 1939.5 2005.8 12371.5 12532.1 12790.4 12873.4 12892.2 1737.4 1739.6 1744.3 1763.9 1773.2 49441.0 50431.7 50594.2 50967.5 51166.5 9015.7 9349.5 9498.9 9663.5 9730.3 12448.7 12451.3 12475.4 12475.8 12500.6 6657.8 6700.1 6701.2 6739.6 6767.5 6150.0 6158.3 6209.4 6211.3 6221.8 4038.7 4105.0 4113.7 4154.2 4156.6 1575.8 1618.4 1625.7 1661.2 1732.4 761.2 773.0 811.3 832.6 927.4 15118.9 15647.9 15866.2 15961.8 16153.0 731.4 793.2 805.5 813.9 833.9 7870.0 8362.6 8471.2 8604.5 8852.0 319908.0 322012.0 323177.0 324408.0 471663.0 51372.7 59804.4 61030.3 61605.7 62701.7 1052.6 1057.6 1077.4 1110.5 1110.5 13587.0 13596.3 14335.8 14421.0 14487.3 32303.0 32543.7 32971.0 33194.3 33473.2 39308.6 39676.4 40647.2 41351.4 41444.0 8299.0 8773.4 8842.1 8844.1 9013.0 10224.8 10238.8 10303.3 12578.3 15806.5 13138.7 13353.3 13516.7 13542.2 13609.0 12724.5 12807.6 12874.8 13293.4 13404.0 14144.6 14147.5 14198.4 14248.6 14316.6 8877.7 8893.0 8902.9 8922.7 9168.4 13818.3 13910.7 13939.9 13988.4 14042.7 21:27:13 INFO - 2015-12-16 21:27:13,328 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,328 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4974.47 Median:6128.10 stddev:2591.58 (42.3%) stddev-sans-first:2582.27 21:27:13 INFO - 2015-12-16 21:27:13,328 DEBUG : BROWSER_OUTPUT: Values: 1075.1 1153.9 1234.9 1619.1 1698.0 6013.4 6993.0 7177.6 7198.4 7209.9 6884.4 6975.0 7015.7 7019.1 7020.6 1733.0 1766.3 2038.8 2072.8 2102.3 2081.3 2091.2 2091.4 2092.4 2092.8 1987.9 2009.8 2060.0 2060.2 2061.9 2040.1 2055.4 2064.3 2094.5 2095.9 2051.6 2073.3 2074.8 2080.8 2082.0 7123.9 7190.4 7191.4 7194.0 7194.7 4084.5 4167.1 4167.3 4176.7 4184.2 2630.8 2698.3 2737.5 2749.0 2763.7 857.8 873.3 877.9 883.7 889.9 9355.8 9573.2 9579.5 9581.7 9593.8 3908.2 3960.4 4058.4 4081.5 4119.3 8407.5 8462.5 8479.9 8493.4 8502.2 4342.1 4403.6 4415.2 4426.9 4430.4 3983.7 4021.0 4022.7 4023.7 4028.6 3086.7 3147.7 3398.4 3409.2 3462.5 1128.3 1145.6 1148.2 1149.5 1151.0 1139.2 1176.0 1214.9 1218.4 1218.8 6598.0 6705.7 6736.8 6738.0 6770.7 584.5 592.0 594.1 594.2 742.1 5308.2 5326.0 5328.6 5338.6 5378.1 8109.4 8504.5 8584.1 8587.5 8594.8 8522.2 8572.0 8600.3 8604.5 8605.5 6706.8 6742.7 6820.3 6838.8 6867.7 6451.0 6481.6 6482.4 6493.1 6498.4 7574.4 7810.9 7821.9 7829.3 7831.5 7666.8 7974.4 7976.0 8099.5 8106.6 6006.2 6119.4 6156.9 6164.9 6186.6 5814.7 6032.2 6492.5 6626.7 6641.9 6458.6 6522.2 6582.9 6604.0 6630.1 6281.9 6300.2 6303.3 6367.8 6386.5 6355.0 6402.6 6413.7 6414.1 6418.7 6084.3 6123.1 6128.0 6128.2 6130.6 5897.2 5951.9 5985.2 6005.5 6164.6 21:27:13 INFO - 2015-12-16 21:27:13,328 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,328 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4638.52 Median:5323.78 stddev:1370.03 (25.7%) stddev-sans-first:1334.44 21:27:13 INFO - 2015-12-16 21:27:13,329 DEBUG : BROWSER_OUTPUT: Values: 290.9 299.3 304.1 311.2 313.5 5296.2 5314.0 5389.9 5400.9 5413.2 5281.4 5315.6 5318.5 5329.0 5330.0 3953.4 4179.6 4183.0 4186.1 4191.5 4031.3 4063.2 4143.1 4164.5 4169.1 4096.8 4114.6 4117.4 4118.4 4127.8 3912.6 4018.9 4021.1 4120.5 4124.5 3652.4 3654.2 3659.2 3667.6 3681.2 5107.7 5114.5 5117.6 5119.1 5131.7 4737.3 4739.7 4740.9 4744.5 4747.7 5455.5 5573.4 5577.7 5580.6 5596.8 3960.1 3960.9 3967.0 3968.9 3977.0 5878.1 5878.7 5880.5 5883.5 5887.1 4091.5 4093.2 4093.5 4093.7 4095.1 3733.3 3785.4 4157.8 4163.6 4164.0 4488.6 4576.9 4581.5 4588.0 4596.8 5439.9 5447.9 5500.7 5581.5 5594.9 1380.8 1414.1 1416.0 1416.3 1420.7 925.9 943.9 954.6 957.3 959.4 4854.9 4875.6 4883.5 4885.5 4887.0 5726.5 5727.5 5745.7 5753.6 5761.8 4843.5 4860.2 4871.6 4872.9 4874.3 2895.7 2954.6 3068.5 3076.4 3095.1 5432.5 5548.3 5550.8 5553.4 5556.3 6015.0 6016.5 6017.2 6019.5 6019.5 5541.9 5546.8 5553.6 5555.6 5557.2 5723.0 5813.6 5839.7 5850.7 5859.6 5651.8 5702.8 5705.0 5708.0 5714.0 5516.9 5521.0 5529.0 5530.5 5535.4 3993.4 4001.2 4004.6 4004.9 4006.2 5673.3 5830.5 5833.4 5834.9 5835.2 5574.8 5577.0 5577.3 5578.4 5580.2 5608.0 5611.4 5614.5 5614.6 5620.0 5354.5 5480.9 5487.3 5488.2 5488.5 5592.7 5600.1 5602.7 5650.2 5654.7 5289.9 5387.3 5450.8 5460.3 5528.3 21:27:13 INFO - 2015-12-16 21:27:13,329 DEBUG : BROWSER_OUTPUT: 21:27:13 INFO - 2015-12-16 21:27:13,330 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11853.97 Median:24548.85 stddev:13460.33 (54.8%) stddev-sans-first:13471.69 21:27:13 INFO - 2015-12-16 21:27:13,330 DEBUG : BROWSER_OUTPUT: Values: 628.5 630.6 653.1 715.7 728.4 11900.3 12082.3 12235.1 12269.8 12275.6 10222.6 11808.3 11891.3 11933.9 11962.3 632.2 801.4 817.9 819.3 819.5 804.9 812.5 817.4 817.4 817.8 667.2 675.9 833.2 835.3 835.8 829.5 844.4 844.6 844.8 845.2 635.7 635.9 635.9 636.6 637.5 11625.2 11877.3 11887.6 11907.8 11933.6 10764.4 11053.9 11146.9 11395.8 11506.9 8881.8 8962.3 8969.6 9279.6 9378.0 3144.9 3151.4 3166.8 3173.7 3221.9 39088.2 39162.6 39176.4 39316.8 39332.0 8981.9 9003.2 9033.3 9038.2 9218.9 15611.4 15636.5 15676.1 15690.8 15787.3 6034.5 6144.7 6162.6 6178.0 6180.4 3365.4 3382.6 3383.6 3492.5 3522.3 2467.9 2497.8 2509.3 2510.8 2516.3 460.7 464.5 472.0 472.6 475.6 486.7 537.3 563.7 590.3 592.3 7369.4 7392.4 7487.6 7501.4 7773.1 457.5 513.6 567.4 580.2 614.3 3656.4 3715.1 3720.9 3743.8 3821.6 48313.0 48373.8 48611.0 48621.0 49385.5 43236.0 43497.8 43505.6 43537.6 43574.8 38225.8 39208.4 39572.6 39601.4 39846.0 7187.7 7286.2 7335.2 7375.3 7511.5 29991.6 30082.5 30300.5 30534.7 30575.0 36950.6 37220.6 38056.6 40483.8 40492.8 9084.7 9539.4 9615.0 9755.4 9765.2 10022.5 10140.6 10506.3 10581.8 10737.4 9553.3 9787.2 9828.9 9861.8 10130.8 9795.2 9918.3 10181.5 10239.0 10250.4 9672.6 9703.1 10044.5 10194.2 10227.5 8310.9 8452.2 8635.9 8692.3 8750.3 7722.5 8357.2 8430.6 8477.3 8555.2 21:27:13 INFO - 2015-12-16 21:27:13,330 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:27:13 INFO - 2015-12-16 21:27:13,330 DEBUG : BROWSER_OUTPUT: 21:27:14 INFO - 2015-12-16 21:27:14,072 INFO : Browser exited with error code: 0 21:27:14 INFO - 2015-12-16 21:27:14,093 INFO : Completed test dromaeo_css (00:18:37) 21:27:14 INFO - 2015-12-16 21:27:14,093 INFO : Starting test kraken 21:27:14 INFO - 2015-12-16 21:27:14,093 DEBUG : operating with platform_type : linux_ 21:27:14 INFO - 2015-12-16 21:27:14,093 INFO : Initialising browser for kraken test... 21:27:14 INFO - 2015-12-16 21:27:14,099 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4nqPN3/profile http://localhost:47944/getInfo.html 21:27:18 INFO - 2015-12-16 21:27:18,175 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:27:18 INFO - 2015-12-16 21:27:18,175 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:27:18 INFO - 2015-12-16 21:27:18,175 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:27:18 INFO - 2015-12-16 21:27:18,175 DEBUG : BROWSER_OUTPUT: __metrics 21:27:18 INFO - 2015-12-16 21:27:18,271 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] 21:27:18 INFO - 2015-12-16 21:27:18,339 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] 21:27:18 INFO - 2015-12-16 21:27:18,637 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 21:27:19 INFO - 2015-12-16 21:27:19,318 INFO : Browser initialized. 21:27:19 INFO - 2015-12-16 21:27:19,318 INFO : Running cycle 1/1 for kraken test... 21:27:19 INFO - 2015-12-16 21:27:19,319 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4nqPN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:27:31 INFO - 2015-12-16 21:27:31,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 140902400 21:27:31 INFO - 2015-12-16 21:27:31,248 DEBUG : BROWSER_OUTPUT: 21:27:33 INFO - 2015-12-16 21:27:33,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47944/tests/kraken/driver.html?testName=audio-beat-detection) 21:27:34 INFO - 2015-12-16 21:27:34,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 176209920 21:27:34 INFO - 2015-12-16 21:27:34,435 DEBUG : BROWSER_OUTPUT: 21:27:37 INFO - 2015-12-16 21:27:37,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47944/tests/kraken/driver.html?testName=audio-dft) 21:27:37 INFO - 2015-12-16 21:27:37,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 164020224 21:27:37 INFO - 2015-12-16 21:27:37,726 DEBUG : BROWSER_OUTPUT: 21:27:40 INFO - 2015-12-16 21:27:40,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47944/tests/kraken/driver.html?testName=audio-fft) 21:27:41 INFO - 2015-12-16 21:27:41,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 149471232 21:27:41 INFO - 2015-12-16 21:27:41,262 DEBUG : BROWSER_OUTPUT: 21:27:43 INFO - 2015-12-16 21:27:43,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47944/tests/kraken/driver.html?testName=audio-oscillator) 21:27:43 INFO - 2015-12-16 21:27:43,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 152150016 21:27:43 INFO - 2015-12-16 21:27:43,869 DEBUG : BROWSER_OUTPUT: 21:27:46 INFO - 2015-12-16 21:27:46,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:27:46 INFO - 2015-12-16 21:27:46,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 155054080 21:27:46 INFO - 2015-12-16 21:27:46,700 DEBUG : BROWSER_OUTPUT: 21:27:49 INFO - 2015-12-16 21:27:49,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47944/tests/kraken/driver.html?testName=imaging-darkroom) 21:27:50 INFO - 2015-12-16 21:27:50,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 155766784 21:27:50 INFO - 2015-12-16 21:27:50,281 DEBUG : BROWSER_OUTPUT: 21:27:53 INFO - 2015-12-16 21:27:53,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47944/tests/kraken/driver.html?testName=imaging-desaturate) 21:27:54 INFO - 2015-12-16 21:27:54,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 156385280 21:27:54 INFO - 2015-12-16 21:27:54,267 DEBUG : BROWSER_OUTPUT: 21:27:57 INFO - 2015-12-16 21:27:57,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47944/tests/kraken/driver.html?testName=json-parse-financial) 21:27:57 INFO - 2015-12-16 21:27:57,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 157151232 21:27:57 INFO - 2015-12-16 21:27:57,695 DEBUG : BROWSER_OUTPUT: 21:27:59 INFO - 2015-12-16 21:27:59,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:28:00 INFO - 2015-12-16 21:28:00,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 164503552 21:28:00 INFO - 2015-12-16 21:28:00,051 DEBUG : BROWSER_OUTPUT: 21:28:01 INFO - 2015-12-16 21:28:01,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:28:02 INFO - 2015-12-16 21:28:02,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 164864000 21:28:02 INFO - 2015-12-16 21:28:02,525 DEBUG : BROWSER_OUTPUT: 21:28:04 INFO - 2015-12-16 21:28:04,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:28:05 INFO - 2015-12-16 21:28:05,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 181174272 21:28:05 INFO - 2015-12-16 21:28:05,243 DEBUG : BROWSER_OUTPUT: 21:28:07 INFO - 2015-12-16 21:28:07,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:28:08 INFO - 2015-12-16 21:28:08,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 182562816 21:28:08 INFO - 2015-12-16 21:28:08,394 DEBUG : BROWSER_OUTPUT: 21:28:11 INFO - 2015-12-16 21:28:11,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:28:11 INFO - 2015-12-16 21:28:11,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 180604928 21:28:11 INFO - 2015-12-16 21:28:11,585 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47944/tests/kraken/driver.html?testName=ai-astar) 21:28:13 INFO - 2015-12-16 21:28:13,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 239816704 21:28:13 INFO - 2015-12-16 21:28:13,646 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,647 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:13 INFO - 2015-12-16 21:28:13,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:13 INFO - 2015-12-16 21:28:13,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:13 INFO - 2015-12-16 21:28:13,648 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:13 INFO - 2015-12-16 21:28:13,648 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;108;113;115;114;101;113;111;113 21:28:13 INFO - 2015-12-16 21:28:13,648 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;134;147;182;130;151;155;134;165;128 21:28:13 INFO - 2015-12-16 21:28:13,648 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;162;161;160;160;162;162;161 21:28:13 INFO - 2015-12-16 21:28:13,649 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;84;89;73;73;73;108;93;72 21:28:13 INFO - 2015-12-16 21:28:13,649 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;127;94;95;95;133;95;95;126 21:28:13 INFO - 2015-12-16 21:28:13,649 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;109;110;109;109;109 21:28:13 INFO - 2015-12-16 21:28:13,649 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;146;147;146;146;146 21:28:13 INFO - 2015-12-16 21:28:13,649 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;96;94;95;95;95 21:28:13 INFO - 2015-12-16 21:28:13,650 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;71;72;71;73;71;81;69;70 21:28:13 INFO - 2015-12-16 21:28:13,650 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;70;69;68;69;68;68;69 21:28:13 INFO - 2015-12-16 21:28:13,650 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;83;95;84;84;86;85;85;86 21:28:13 INFO - 2015-12-16 21:28:13,650 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;126;126;131;119;119;129;123;130;127 21:28:13 INFO - 2015-12-16 21:28:13,651 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;134;148;145;145;134;138;145;146;136 21:28:13 INFO - 2015-12-16 21:28:13,651 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;73;69;69;69;69;68;68;68 21:28:13 INFO - 2015-12-16 21:28:13,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:13 INFO - 2015-12-16 21:28:13,651 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:28:13 INFO - 2015-12-16 21:28:13,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,999 21:28:13 INFO - 2015-12-16 21:28:13,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:28:13 INFO - 2015-12-16 21:28:13,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1450330093645__endTimestamp 21:28:13 INFO - 2015-12-16 21:28:13,652 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:4.09 (3.6%) stddev-sans-first:4.32 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 108.0 113.0 115.0 114.0 101.0 113.0 111.0 113.0 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.50 stddev:17.18 (11.3%) stddev-sans-first:18.08 21:28:13 INFO - 2015-12-16 21:28:13,656 DEBUG : BROWSER_OUTPUT: Values: 154.0 134.0 147.0 182.0 130.0 151.0 155.0 134.0 165.0 128.0 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 162.0 161.0 160.0 160.0 162.0 162.0 161.0 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:12.18 (16.5%) stddev-sans-first:12.71 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 84.0 89.0 73.0 73.0 73.0 108.0 93.0 72.0 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:95.00 stddev:16.37 (17.2%) stddev-sans-first:16.95 21:28:13 INFO - 2015-12-16 21:28:13,657 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 127.0 94.0 95.0 95.0 133.0 95.0 95.0 126.0 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 21:28:13 INFO - 2015-12-16 21:28:13,658 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 96.0 94.0 95.0 95.0 95.0 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:71.50 stddev:3.31 (4.6%) stddev-sans-first:3.49 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 72.0 71.0 73.0 71.0 81.0 69.0 70.0 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 70.0 69.0 68.0 69.0 68.0 68.0 69.0 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.47 (4.1%) stddev-sans-first:3.54 21:28:13 INFO - 2015-12-16 21:28:13,659 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 83.0 95.0 84.0 84.0 86.0 85.0 85.0 86.0 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.50 stddev:4.65 (3.7%) stddev-sans-first:4.42 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: Values: 119.0 126.0 126.0 131.0 119.0 119.0 129.0 123.0 130.0 127.0 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:145.00 stddev:5.34 (3.7%) stddev-sans-first:5.63 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: Values: 143.0 134.0 148.0 145.0 145.0 134.0 138.0 145.0 146.0 136.0 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 73.0 69.0 69.0 69.0 69.0 68.0 68.0 68.0 21:28:13 INFO - 2015-12-16 21:28:13,660 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:13 INFO - 2015-12-16 21:28:13,661 DEBUG : BROWSER_OUTPUT: 21:28:14 INFO - 2015-12-16 21:28:14,520 INFO : Browser exited with error code: 0 21:28:14 INFO - 2015-12-16 21:28:14,574 INFO : Completed test kraken (00:01:00) 21:28:14 INFO - 2015-12-16 21:28:14,574 INFO : Starting test v8_7 21:28:14 INFO - 2015-12-16 21:28:14,574 DEBUG : operating with platform_type : linux_ 21:28:14 INFO - 2015-12-16 21:28:14,574 INFO : Initialising browser for v8_7 test... 21:28:14 INFO - 2015-12-16 21:28:14,580 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZUC0S/profile http://localhost:47944/getInfo.html 21:28:18 INFO - 2015-12-16 21:28:18,819 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:28:18 INFO - 2015-12-16 21:28:18,820 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:28:18 INFO - 2015-12-16 21:28:18,820 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:28:18 INFO - 2015-12-16 21:28:18,820 DEBUG : BROWSER_OUTPUT: __metrics 21:28:18 INFO - 2015-12-16 21:28:18,924 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] 21:28:18 INFO - 2015-12-16 21:28:18,985 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] 21:28:19 INFO - 2015-12-16 21:28:19,799 INFO : Browser initialized. 21:28:19 INFO - 2015-12-16 21:28:19,799 INFO : Running cycle 1/1 for v8_7 test... 21:28:19 INFO - 2015-12-16 21:28:19,799 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZUC0S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:28:31 INFO - 2015-12-16 21:28:31,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 142864384 21:28:31 INFO - 2015-12-16 21:28:31,771 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47944/tests/v8_7/run.html (next: http://localhost:47944/tests/v8_7/run.html) 21:28:53 INFO - 2015-12-16 21:28:53,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 445009920 21:28:53 INFO - 2015-12-16 21:28:53,435 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: |0;Richards;169.89466530750934 21:28:53 INFO - 2015-12-16 21:28:53,436 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.1850679575498 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |7;RegExp;27351.35135135135 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1363088057901 21:28:53 INFO - 2015-12-16 21:28:53,437 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: __startTimestamp1450330133434__endTimestamp 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,438 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.89 Median:169.89 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: Values: 169.9 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: Values: 186.2 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,439 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,440 DEBUG : BROWSER_OUTPUT: Values: 278.5 21:28:53 INFO - 2015-12-16 21:28:53,440 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,440 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,440 DEBUG : BROWSER_OUTPUT: Values: 5186.5 21:28:53 INFO - 2015-12-16 21:28:53,441 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,441 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,442 DEBUG : BROWSER_OUTPUT: Values: 1964.6 21:28:53 INFO - 2015-12-16 21:28:53,442 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,442 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,442 DEBUG : BROWSER_OUTPUT: Values: 791.8 21:28:53 INFO - 2015-12-16 21:28:53,443 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,443 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,443 DEBUG : BROWSER_OUTPUT: Values: 12292.7 21:28:53 INFO - 2015-12-16 21:28:53,443 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,443 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27351.35 Median:27351.35 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,444 DEBUG : BROWSER_OUTPUT: Values: 27351.4 21:28:53 INFO - 2015-12-16 21:28:53,444 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,444 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,444 DEBUG : BROWSER_OUTPUT: Values: 603.1 21:28:53 INFO - 2015-12-16 21:28:53,445 DEBUG : BROWSER_OUTPUT: 21:28:53 INFO - 2015-12-16 21:28:53,445 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 21:28:53 INFO - 2015-12-16 21:28:53,445 DEBUG : BROWSER_OUTPUT: Values: 4845.4 21:28:53 INFO - 2015-12-16 21:28:53,445 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:53 INFO - 2015-12-16 21:28:53,445 DEBUG : BROWSER_OUTPUT: 21:28:54 INFO - 2015-12-16 21:28:54,360 INFO : Browser exited with error code: 0 21:28:54 INFO - 2015-12-16 21:28:54,374 INFO : Completed test v8_7 (00:00:39) 21:28:54 INFO - 2015-12-16 21:28:54,457 INFO : Completed test suite (00:20:17) 21:28:54 INFO - 2015-12-16 21:28:54,457 DEBUG : Working with test: dromaeo_css 21:28:54 INFO - 2015-12-16 21:28:54,457 DEBUG : Generating results file: dromaeo_css 21:28:54 INFO - 2015-12-16 21:28:54,458 DEBUG : Working with test: kraken 21:28:54 INFO - 2015-12-16 21:28:54,458 DEBUG : Generating results file: kraken 21:28:54 INFO - 2015-12-16 21:28:54,458 INFO : javascript benchmark 21:28:54 INFO - 2015-12-16 21:28:54,458 DEBUG : Working with test: v8_7 21:28:54 INFO - 2015-12-16 21:28:54,459 DEBUG : Generating results file: v8_7 21:28:54 INFO - 2015-12-16 21:28:54,459 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:54 INFO - 2015-12-16 21:28:54,521 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 21:28:54 INFO - 2015-12-16 21:28:54,521 DEBUG : process_Request line: dromaeo_css 6222.76 graph.html#tests=[[72,203,35]] 21:28:54 INFO - 2015-12-16 21:28:54,521 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:54 INFO - 2015-12-16 21:28:54,551 DEBUG : process_Request line: kraken 1519.80 graph.html#tests=[[232,203,35]] 21:28:54 INFO - 2015-12-16 21:28:54,551 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:54 INFO - 2015-12-16 21:28:54,578 DEBUG : process_Request line: v8_7 19726.59 graph.html#tests=[[230,203,35]] 21:28:54 INFO - 2015-12-16 21:28:54,580 INFO : javascript benchmark 21:28:54 INFO - 2015-12-16 21:28:54,583 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2639.947201055979, 2734.179746076177, 2734.2890848379416, 2746.299693578137, 2751.7248275172487, 4562.817487300504, 4697.389339385883, 4748.382710247667, 4768.427788665365, 4787.712737235768, 4719.952800471994, 4730.053989202164, 4838.371011768474, 4842.201036828919, 4866.416030076387, 4300.505441874193, 4334.371516130159, 4368.388425620416, 4421.88945276369, 4424.756638384888, 4412.0955204183065, 4515.954840451603, 4531.592156705896, 4534.501204867462, 4543.681942264043, 4174.645155161815, 4278.336857787048, 4290.721103128287, 4466.82132714691, 4516.480604730433, 4206.831726730927, 4303.35449682547, 4305.870823875289, 4306.20335237982, 4318.935215971763, 4374.540673229297, 4381.890452738675, 4390.143921935224, 4396.3614941438655, 4417.602415782563, 4429.911401771947, 4656.837010704643, 4696.671233013691, 4711.646626502992, 4735.242361222188, 4947.975260123676, 4969.925451118236, 5045.5459008689395, 5128.358955130609, 5165.845024649267, 5124.0, 5148.742562871841, 5152.562032227265, 5156.484351564851, 5156.742162891878, 4554.20301447252, 4766.404199475066, 4776.761161941889, 4777.713337199744, 4821.710697358135, 5134.922976155361, 5154.407243167008, 5158.587313014949, 5228.9738551307, 5238.528532432099, 4996.475370086088, 4998.4251811042195, 5002.074616196015, 5006.023825354094, 5046.823361182341, 4846.975765121152, 5083.2375143727995, 5085.796568137233, 5088.949110508922, 5104.69371837691, 4934.333864928189, 4940.802367905244, 4963.255511673278, 4964.553190212898, 5058.54473097423, 5056.519630635084, 5073.34046573943, 5076.035553244946, 5079.796808127633, 5084.415292241366, 4258.5954334338185, 4262.42457268271, 4271.9786401067795, 4304.053108316165, 4307.569243075667, 3571.571411430593, 3659.3779057559746, 3682.208325210093, 3690.760100593453, 3756.887293381203, 4329.610335069859, 4385.978070109692, 4387.517373088957, 4391.8682439526865, 4427.623651989553, 5075.2387141929, 5113.309703190096, 5157.63896527247, 5164.92252616211, 5205.583553315726, 4221.303484925014, 4350.303951367766, 4416.447944006999, 4422.181896349186, 4472.686911916135, 4430.601245887886, 4442.933355999598, 4453.042595841909, 4478.865634030984, 4515.503294637587, 4833.299171620166, 4837.298591704112, 4839.733814640229, 4840.8789780254365, 4874.561289483963, 4836.733979631013, 4941.6293777966075, 5074.086664400444, 5077.8730531737, 5131.281620573048, 4700.529947005272, 4776.522347765195, 4821.590164836029, 4835.492273311252, 4839.637027222902, 5019.52314530119, 5056.418511871182, 5065.417476990193, 5070.746462676925, 5110.437851836369, 5130.48695130484, 5132.178851383761, 5139.922901156411, 5142.717150556755, 5184.844454666366, 4667.696599721143, 4723.291506274087, 4780.928286075781, 4857.684250523705, 4977.502249774993, 4912.066707325596, 4931.48219436954, 4931.827386041471, 4938.506149385033, 4983.053219888209, 4828.686135401188, 4840.177169881199, 4848.466668666514, 4851.248056551241, 4877.195262781602, 4705.364775755366, 4792.448868380181, 4862.319275301531, 4864.124457597666, 4920.950790492049, 4807.302941073594, 4819.204831202953, 4824.469308376146, 4828.444728856227, 4874.95125048745], "unit": "score", "name": "dojo.html", "value": 4649.587290351633}, {"lowerIsBetter": false, "replicates": [551.8510002299377, 556.3212880286052, 569.843293094399, 573.787698551536, 579.0908274009804, 26102.86948565257, 26716.465670686597, 34440.31119377614, 34844.82577587115, 34889.0, 38541.0, 38920.416193757046, 39051.41422878652, 39062.41406378907, 39217.0, 6913.861722765541, 7796.766097017085, 7959.403044771636, 7970.123286438487, 7970.322522585587, 7034.155901291852, 7117.964410177942, 7122.964385178067, 7130.643467826614, 9439.764005899839, 9608.615655373776, 9703.563339649732, 9705.75735606612, 9713.757156071084, 9717.562709678046, 9843.26175536834, 9990.500474976223, 9991.90008099917, 9997.250206234525, 10002.299839011272, 7101.041359416516, 7289.088863892013, 9672.951635241849, 9921.206303495703, 9923.503824808802, 33387.16532086693, 33872.0, 33891.661083389095, 33904.49143262853, 33910.83044584761, 2939.544370622557, 3649.6532829381167, 3678.7608805427562, 3744.812759362021, 3757.4927384802977, 27217.0, 27524.724752752416, 27581.172564823086, 27985.020524281757, 28448.0, 3288.96711032889, 3306.7354611631013, 3329.334133173375, 3362.142653623335, 3413.4026545354714, 211329.0, 211342.0, 211343.0, 211447.0, 275541.0, 41273.0, 57238.7138064307, 59039.40960590339, 59051.0, 59078.40921590815, 51350.74324628353, 51634.48365516372, 51682.48317516777, 51777.7411112942, 51790.741046294526, 13266.867331326755, 13595.592132236048, 13603.659908502366, 13604.047716659938, 13606.387712552762, 10205.897941020643, 10462.267641265038, 10466.947665261625, 10471.633492827867, 10476.161907047417, 17619.911900440417, 17857.732134018, 17858.91070544639, 17887.642247155243, 17906.28374865017, 6958.130233720785, 7011.789646310517, 7051.1891132519395, 7086.893696594555, 7203.747868824566, 827.7227128911882, 907.9863802042843, 1052.8631277933819, 1061.6602687140196, 1080.0549519170725, 26210.73789262083, 26283.737162628127, 26440.73559264421, 26613.600795988077, 26689.3327666806, 981.8120074709539, 1006.3207335048813, 1014.6347314966606, 1042.838360054193, 1110.1119104716195, 13908.0, 13932.233727145105, 14440.350184241734, 14638.487652932095, 14685.632859178606, 261627.0, 265804.0, 266035.0, 266411.0, 266713.0, 45928.77035614867, 45995.77002114968, 46176.7691161542, 46223.07553848904, 46232.3065154023, 1222.6637674639367, 1222.9082818788627, 1246.307974774501, 1247.6818411305242, 1253.2104773992326, 25346.239612811645, 25946.74053259443, 26045.0, 26358.868205658848, 26381.736182638695, 38730.22539549137, 38974.220515590096, 39089.218215636094, 39095.0, 39141.41287880627, 241858.0, 243700.0, 243900.0, 244433.0, 245284.0, 24087.0, 24364.63453048241, 27263.318417039733, 27304.044358447358, 28322.575161372184, 33154.834225828716, 33327.666723332455, 33534.16164595807, 33551.81257780507, 33778.8311058453, 30836.84581577078, 31246.18784309423, 31709.048728538182, 32269.0, 32464.188395289362, 26294.60558091592, 29960.0, 31607.525887111253, 31911.042668719976, 32165.517517236793, 28959.13122606325, 29372.412551749272, 29532.409351813272, 29565.556516652698, 29598.260043499085, 24381.51236975286, 28684.85657571699, 29501.26246843846, 29602.891696372433, 29647.25881852971, 22923.31230063101, 22953.540929181658, 23015.654765178202, 23040.4239894004, 23275.650865237374], "unit": "score", "name": "ext.html", "value": 16691.29886880647}, {"lowerIsBetter": false, "replicates": [336.43478955355, 336.5591075690845, 338.7916431394693, 338.9237421580145, 341.79150718061993, 12478.438470268837, 12846.48614055439, 14894.47869324574, 15030.473933412333, 15568.455104071345, 12577.496900123984, 14600.780988285183, 14710.043847149955, 14896.25518724065, 14909.478168264113, 4282.122164956177, 4428.136513379876, 4922.999999999991, 4961.131801934665, 5064.898702025957, 3680.8527658893613, 3784.12965018046, 3786.924261514768, 3788.2234142000825, 4939.407271127452, 3763.5671897731836, 3771.66055055045, 5599.41206173352, 5722.456366645183, 5766.0486019806685, 5553.0, 5643.915341269884, 5677.574181936371, 5677.886442271173, 5719.142128680711, 4953.752312384367, 4957.479464656195, 4958.677685950402, 4960.2063669813015, 4987.376577927759, 17709.645807083914, 18256.452306430827, 18338.90830545852, 18344.0, 19293.131809068625, 1863.683173860447, 1867.8599105067174, 1876.136976990586, 1939.5054261163455, 2005.8495612828951, 12371.505139794397, 12532.122751407405, 12790.424430900539, 12873.356332183354, 12892.162009469355, 1737.444017914268, 1739.5738044179257, 1744.345870298638, 1763.8765286429955, 1773.1666116925026, 49441.0, 50431.74784126093, 50594.241086383736, 50967.490325096645, 51166.48833511692, 9015.684451044182, 9349.53252337394, 9498.90501094994, 9663.46850923192, 9730.270229732656, 12448.688782780502, 12451.315177665316, 12475.376231188404, 12475.812862807064, 12500.562480313145, 6657.833554161088, 6700.128983232246, 6701.1623547056615, 6739.5619284746335, 6767.52627316093, 6149.96925015372, 6158.322584515699, 6209.441150296495, 6211.3167551569295, 6221.844453888599, 4038.737482063715, 4104.958950410517, 4113.691473139466, 4154.169166166779, 4156.605122513356, 1575.7951466309307, 1618.409280612568, 1625.6992456395606, 1661.2275291989283, 1732.3936622182387, 761.2159475739996, 772.9536227826236, 811.2779626132747, 832.6086739232551, 927.420362273579, 15118.924405377902, 15647.921760391126, 15866.206689665702, 15961.760573591406, 16153.0, 731.3564063623977, 793.1909452358677, 805.5166899860154, 813.9267465928095, 833.8957630296213, 7869.960650196713, 8362.623681934327, 8471.195236452528, 8604.48373097616, 8851.955740221258, 319908.0, 322012.0, 323177.0, 324408.0, 471663.0, 51372.74313628483, 59804.40195597988, 61030.33817970936, 61605.691971539854, 62701.68649156725, 1052.5684469367675, 1057.5716834681966, 1077.42357838556, 1110.4503270880805, 1110.4558766204502, 13587.0, 13596.348712001065, 14335.784963225351, 14421.0, 14487.275636218357, 32303.0, 32543.674563254066, 32971.0, 33194.336113278085, 33473.163170920925, 39308.6069139305, 39676.40485392664, 40647.1870562593, 41351.37972930469, 41444.0, 8298.958505207434, 8773.42972706772, 8842.071582484004, 8844.115588441104, 9013.0, 10224.846627300447, 10238.846417303896, 10303.278770486293, 12578.30819304947, 15806.525804225892, 13138.73722525525, 13353.265570393332, 13516.729665406834, 13542.187468751907, 13609.0, 12724.491020359452, 12807.551735689207, 12874.806877896652, 13293.401796919356, 13404.0, 14144.575662730134, 14147.504837330644, 14198.361073751912, 14248.572542823731, 14316.57050288493, 8877.73366798997, 8893.0, 8902.910970890209, 8922.73231803047, 9168.44989300644, 13818.309084545934, 13910.721785564434, 13939.930300348433, 13988.370523326272, 14042.719145617235], "unit": "score", "name": "jquery.html", "value": 7966.492013833141}, {"lowerIsBetter": false, "replicates": [1075.1022895881938, 1153.873073961864, 1234.9197302175353, 1619.1013987237081, 1697.9660406791868, 6013.368596297391, 6992.965035174823, 7177.641117944095, 7198.424126069908, 7209.855802883939, 6884.414824739891, 6974.96512517438, 7015.684294206761, 7019.052427922242, 7020.648967551615, 1733.0035229742884, 1766.293482606961, 2038.7859274776158, 2072.82380997615, 2102.316747057205, 2081.3131666550003, 2091.2366986050133, 2091.351680978894, 2092.4245832396136, 2092.7593326767465, 1987.9403617891414, 2009.8392128629675, 2059.979400205994, 2060.248009476538, 2061.8556701030934, 2040.1431398812535, 2055.4142069510194, 2064.298138632872, 2094.52873103552, 2095.8952052397394, 2051.6204502166997, 2073.284716772711, 2074.761402438724, 2080.771115177329, 2081.9687704684443, 7123.857522849566, 7190.352868241831, 7191.424686025158, 7194.0, 7194.7122115115335, 4084.509858816961, 4167.083241686824, 4167.312393455076, 4176.749395036308, 4184.205001049791, 2630.8289961152464, 2698.3016983016983, 2737.54830452975, 2749.024096445753, 2763.69599344072, 857.8327226190895, 873.2708188662474, 877.8727084572765, 883.650957871637, 889.8843150390472, 9355.812883742356, 9573.234141268682, 9579.521023948844, 9581.712548623553, 9593.760155996017, 3908.179282350681, 3960.405939109099, 4058.350663893763, 4081.5306239782803, 4119.258533463945, 8407.453515521594, 8462.534560599102, 8479.872801907977, 8493.44792588492, 8502.192291732275, 4342.131573685276, 4403.625691816232, 4415.227335216325, 4426.867193984185, 4430.424044874146, 3983.741056831355, 4020.979895100564, 4022.718409711292, 4023.7183397162503, 4028.617281358266, 3086.66046734859, 3147.669494703069, 3398.405279076201, 3409.1647546350805, 3462.4633181856852, 1128.2666266926399, 1145.5818626201376, 1148.1962626161553, 1149.528693235786, 1150.9769804603861, 1139.1968662093204, 1175.9706007349714, 1214.908881833866, 1218.421249906305, 1218.7867123253395, 6598.0, 6705.731770729214, 6736.797896063126, 6737.9663101685155, 6770.72917083321, 584.4593750780596, 592.026117037471, 594.147398483178, 594.1948659566311, 742.0835268443468, 5308.177232528964, 5325.961437519646, 5328.626996110235, 5338.572914166857, 5378.058839703036, 8109.432339736162, 8504.489730616182, 8584.098669639598, 8587.527685977206, 8594.828103437896, 8522.232999030117, 8571.95714021426, 8600.311975042106, 8604.526751028754, 8605.483670979762, 6706.765263215764, 6742.730290788313, 6820.283870193657, 6838.794836154824, 6867.725290988405, 6451.0, 6481.643509607017, 6482.448991835747, 6493.058506516623, 6498.415142637185, 7574.394048476219, 7810.921890781019, 7821.882671759814, 7829.29536341732, 7831.451798374059, 7666.769996900102, 7974.362051036019, 7976.0, 8099.514029158034, 8106.635201416068, 6006.15913772081, 6119.388061193845, 6156.876862462816, 6164.938350616437, 6186.628802271878, 5814.709264536672, 6032.1856549365275, 6492.513061520499, 6626.6686665667485, 6641.937290033571, 6458.61248325102, 6522.249941256627, 6582.868342633216, 6603.966980165068, 6630.071789949315, 6281.937180628135, 6300.21247344082, 6303.338149494421, 6367.777127800505, 6386.457151142019, 6354.968225158845, 6402.551821372459, 6413.679316034273, 6414.10202571631, 6418.711157997995, 6084.33072362031, 6123.112148738497, 6128.0, 6128.203333566787, 6130.601510901777, 5897.174395584536, 5951.940480595139, 5985.191999080069, 6005.459508644243, 6164.630122192682], "unit": "score", "name": "mootools.html", "value": 4046.440724912388}, {"lowerIsBetter": false, "replicates": [290.8574798348809, 299.28918817807704, 304.108960745017, 311.2312587907867, 313.46241196348257, 5296.152615581503, 5314.0, 5389.892202155965, 5400.891982160354, 5413.188021796733, 5281.392639846419, 5315.574754019679, 5318.521333080022, 5329.040772660929, 5330.0, 3953.446517487554, 4179.6029377209115, 4182.97908510457, 4186.079062606222, 4191.5179754328265, 4031.3146765049864, 4063.207674503473, 4143.129942712034, 4164.541900390955, 4169.061961058753, 4096.774677392757, 4114.567970363114, 4117.402976568395, 4118.423420721101, 4127.752334859903, 3912.6087391260644, 4018.8794336169963, 4021.1153546219784, 4120.526139493952, 4124.525679546846, 3652.397354436515, 3654.2326111516613, 3659.249853779969, 3667.6149004354693, 3681.1901381695984, 5107.7446127693465, 5114.514121158484, 5117.6161787865685, 5119.129747942859, 5131.692098474104, 4737.313089602023, 4739.715617062952, 4740.928886066712, 4744.501827308118, 4747.667663263573, 5455.509004189642, 5573.359063707685, 5577.69322687252, 5580.609357344987, 5596.776128954837, 3960.1089754805225, 3960.940585891214, 3967.02807812085, 3968.940465893014, 3977.0, 5878.118282257653, 5878.735456904406, 5880.529557635379, 5883.499902508292, 5887.116932460122, 4091.5294741105154, 4093.16090201508, 4093.5087789465456, 4093.672506199497, 4095.1400205957084, 3733.328000959799, 3785.413260944558, 4157.812898419578, 4163.604457576525, 4164.042270277853, 4488.618467430305, 4576.8626941191815, 4581.450225972904, 4587.9541204588195, 4596.770161491979, 5439.891202175934, 5447.945520544823, 5500.724963751796, 5581.5255703265675, 5594.916076258859, 1380.827396575428, 1414.0667159674565, 1415.9804940442864, 1416.3343228682502, 1420.7158568286384, 925.9120383563551, 943.8914524829595, 954.5895265036102, 957.2581249531529, 959.4243453927587, 4854.878628034327, 4875.634327425457, 4883.4628190898975, 4885.511448855157, 4886.975565122151, 5726.455986681259, 5727.4845263926445, 5745.6552606843725, 5753.62601430914, 5761.798337058183, 4843.539863712942, 4860.198067318924, 4871.610271178297, 4872.878178045577, 4874.341963834837, 2895.739383455457, 2954.615899933038, 3068.4936985397158, 3076.430860290853, 3095.086949349947, 5432.511074003359, 5548.278723765885, 5550.750216240198, 5553.444655534495, 5556.277683901067, 6015.037593984942, 6016.488598469179, 6017.187679663277, 6019.488343490765, 6019.518438524908, 5541.9168712469345, 5546.77812887488, 5553.611247212656, 5555.611107222537, 5557.194206840067, 5723.0, 5813.56398270123, 5839.708014599168, 5850.707464626837, 5859.58982871212, 5651.802186923438, 5702.800401985911, 5705.030144875298, 5708.0, 5714.000049991318, 5516.862078448071, 5520.972395137998, 5529.0, 5530.474604912527, 5535.39110697831, 3993.440918271386, 4001.1797581495143, 4004.599540045972, 4004.8798536043964, 4006.238814625212, 5673.347565030074, 5830.5044071254415, 5833.416658334133, 5834.912476312774, 5835.241418615553, 5574.77700891976, 5577.0, 5577.298923828109, 5578.414266501959, 5580.2466666999435, 5607.971960140173, 5611.354694210055, 5614.494695477427, 5614.550835933034, 5619.971900140473, 5354.54486368663, 5480.890382192413, 5487.341519017744, 5488.1767734838495, 5488.451154884479, 5592.692401917933, 5600.0759874620235, 5602.663840169603, 5650.208970744181, 5654.745536450787, 5289.920651190158, 5387.299651045339, 5450.836474905759, 5460.290162278879, 5528.336599608073], "unit": "score", "name": "prototype.html", "value": 4195.320954514214}, {"lowerIsBetter": false, "replicates": [628.4658040665435, 630.5869655375731, 653.1280740211816, 715.7423327602062, 728.3626826526789, 11900.285982841036, 12082.33547154906, 12235.143539952218, 12269.754604907897, 12275.631731048072, 10222.642207522738, 11808.291502509834, 11891.345975971319, 11933.940330298336, 11962.342071186082, 632.2065807411703, 801.4029547986729, 817.9222973817508, 819.2749416766175, 819.4632515702225, 804.90341159061, 812.5165526511746, 817.4278005396217, 817.435969181266, 817.750586071248, 667.2426795586995, 675.8715843989626, 833.2251006563893, 835.2649668291895, 835.7994081420446, 829.5478963964623, 844.3582877013514, 844.6452489954233, 844.8014716541577, 845.247729520727, 635.7202830754453, 635.8823617630753, 635.8887194740902, 636.5798572941883, 637.4995628431706, 11625.186236963416, 11877.346745928971, 11887.643370698894, 11907.821382679267, 11933.641990740292, 10764.354138751622, 11053.894610538962, 11146.888531114666, 11395.829062564067, 11506.94246528762, 8881.777955551162, 8962.283017358595, 8969.551522423919, 9279.582418791104, 9378.015308392589, 3144.8584813683437, 3151.416987857254, 3166.8118122080723, 3173.666764989666, 3221.887233946824, 39088.21823563541, 39162.60837391647, 39176.41235381472, 39316.80341598274, 39332.0, 8981.910180898238, 9003.234725048313, 9033.322500812465, 9038.231750301298, 9218.907810921804, 15611.375544978073, 15636.530904072668, 15676.05943643385, 15690.76463853043, 15787.28957196929, 6034.465623819834, 6144.662043587646, 6162.630242185393, 6178.042403427476, 6180.351063138396, 3365.4278772608714, 3382.5771778527683, 3383.5601371821504, 3492.5459690240614, 3522.295540891832, 2467.8889449974795, 2497.8126640502037, 2509.2723110298175, 2510.79913606911, 2516.27028161831, 460.7028466638999, 464.4937018649688, 472.04882162442703, 472.5723220485466, 475.62188060491303, 486.7079752148753, 537.3498067338564, 563.6646195513663, 590.2533295381346, 592.3070008090544, 7369.410447164214, 7392.371648409838, 7487.550746955091, 7501.399888008947, 7773.106092799288, 457.47162027857877, 513.599392473871, 567.4439049731286, 580.1848402993801, 614.2598169206096, 3656.3966945453703, 3715.0898029982827, 3720.869769558107, 3743.7753734775456, 3821.617838216156, 48313.0, 48373.75813120982, 48611.0, 48621.0, 49385.50614493881, 43236.0, 43497.78251108724, 43505.56494435079, 43537.56462435398, 43574.7821260898, 38225.808870955465, 39208.41187382192, 39572.60427395747, 39601.40597891034, 39846.0, 7187.712491500281, 7286.234945330664, 7335.156457007299, 7375.262473752582, 7511.51175173612, 29991.550126748552, 30082.548761768154, 30300.54549181808, 30534.694653054074, 30575.0, 36950.63049369472, 37220.62779372172, 38056.61943380531, 40483.79758101308, 40492.797536012135, 9084.682036128705, 9539.427634341962, 9615.0, 9755.365901216683, 9765.218782497524, 10022.498875056364, 10140.645077422254, 10506.264561480622, 10581.788364232827, 10737.409442480739, 9553.331266811534, 9787.21702263803, 9828.852567211641, 9861.802763944537, 10130.797384052425, 9795.167410770164, 9918.256130790076, 10181.541830617492, 10238.9761023897, 10250.38497690141, 9672.613095476103, 9703.12671859536, 10044.547995340374, 10194.235432342455, 10227.48862556884, 8310.91744667334, 8452.154784521745, 8635.920509936257, 8692.33286072639, 8750.256228220673, 7722.498037627536, 8357.247847693738, 8430.578471076544, 8477.338447626387, 8555.187257210555], "unit": "score", "name": "yui.html", "value": 5531.502845342682}], "name": "dromaeo_css", "value": 6222.7585849041725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 113.0, 115.0, 114.0, 101.0, 113.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 147.0, 182.0, 130.0, 151.0, 155.0, 134.0, 165.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 84.0, 89.0, 73.0, 73.0, 73.0, 108.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 127.0, 94.0, 95.0, 95.0, 133.0, 95.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 71.0, 73.0, 71.0, 81.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 70.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 83.0, 95.0, 84.0, 84.0, 86.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 126.0, 131.0, 119.0, 119.0, 129.0, 123.0, 130.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 148.0, 145.0, 145.0, 134.0, 138.0, 145.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 73.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1519.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.89466530750934], "unit": "score", "name": "Richards", "value": 207.78757200000007}, {"lowerIsBetter": false, "replicates": [186.1850679575498], "unit": "score", "name": "DeltaBlue", "value": 355.1197780000001}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [27351.35135135135], "unit": "score", "name": "RegExp", "value": 33.306763833992065}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19726.58991969735}]} 21:28:54 INFO - RETURN: dromaeo_css: 6222.76 21:28:54 INFO - RETURN: kraken: 1519.80 21:28:54 INFO - RETURN: v8_7: 19726.59 21:28:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19726.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1519.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6222.76"}}} 21:28:54 INFO - Return code: 0 21:28:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:28:54 INFO - # TBPL SUCCESS # 21:28:54 INFO - Running post-action listener: _resource_record_post_action 21:28:54 INFO - Running post-run listener: _resource_record_post_run 21:28:55 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 509595648; Read time: 0; Write time: 485156 21:28:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231743488; Read time: 0; Write time: 305112 21:28:55 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 277852160; Read time: 0; Write time: 180044 21:28:55 INFO - Running post-run listener: _upload_blobber_files 21:28:55 INFO - Blob upload gear active. 21:28:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:28:55 INFO - Copying logs to upload dir... 21:28:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.049447 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-16 21:28:55.034246) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 21:28:55.037443) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010300 build_url: 'https://queue.taskcluster.net/v1/task/j6f1S-MtT5SzL_IH-pvOrw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 21:28:55.093685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:28:55.094459) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450328091.897149-846180209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 21:28:55.147016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 21:28:55.147591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 21:28:55.148189) ========= ========= Total master_lag: 0.25 =========