builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1465923805.65 results: success (0) buildid: 20160614073236 builduid: 387f0a94260c46568fbad355806b489e revision: b1e2e1c0e5912f7ad331950b63871a72ac2807a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.648689) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.649113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.649392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.685074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.685402) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 10:03:26-- 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% 66.7M=0s 2016-06-14 10:03:26 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.813663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.813985) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015045 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.863112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:25.863445) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b1e2e1c0e5912f7ad331950b63871a72ac2807a5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b1e2e1c0e5912f7ad331950b63871a72ac2807a5 --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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 10:03:26,654 truncating revision to first 12 chars 2016-06-14 10:03:26,654 Setting DEBUG logging. 2016-06-14 10:03:26,654 attempt 1/10 2016-06-14 10:03:26,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b1e2e1c0e591?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 10:03:26,933 unpacking tar archive at: mozilla-inbound-b1e2e1c0e591/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:26.508068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:26.508381) ========= script_repo_revision: b1e2e1c0e5912f7ad331950b63871a72ac2807a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:26.508778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:26.509060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 10:03:26.519294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-14 10:03:26.519638) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:03:27 INFO - MultiFileLogger online at 20160614 10:03:27 in /builds/slave/test 10:03:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:03:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:03:27 INFO - {'append_to_log': False, 10:03:27 INFO - 'base_work_dir': '/builds/slave/test', 10:03:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:03:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:03:27 INFO - 'branch': 'Mozilla-Inbound', 10:03:27 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:27 INFO - 'config_files': ('talos/linux_config.py',), 10:03:27 INFO - 'default_actions': ('clobber', 10:03:27 INFO - 'read-buildbot-config', 10:03:27 INFO - 'download-and-extract', 10:03:27 INFO - 'populate-webroot', 10:03:27 INFO - 'create-virtualenv', 10:03:27 INFO - 'install', 10:03:27 INFO - 'run-tests'), 10:03:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:27 INFO - 'download_minidump_stackwalk': True, 10:03:27 INFO - 'download_symbols': 'ondemand', 10:03:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:03:27 INFO - 'tooltool.py': '/tools/tooltool.py', 10:03:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:03:27 INFO - '/tools/misc-python/virtualenv.py')}, 10:03:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:27 INFO - 'installer_path': 'installer.exe', 10:03:27 INFO - 'log_level': 'info', 10:03:27 INFO - 'log_name': 'talos', 10:03:27 INFO - 'log_to_console': True, 10:03:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:03:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:03:27 INFO - 'opt_config_files': (), 10:03:27 INFO - 'pip_index': False, 10:03:27 INFO - 'sps_profile': False, 10:03:27 INFO - 'sps_profile_interval': 0, 10:03:27 INFO - 'suite': 'dromaeojs-e10s', 10:03:27 INFO - 'system_bits': '32', 10:03:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:27 INFO - 'title': 'talos-linux64-ix-013', 10:03:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:03:27 INFO - 'use_talos_json': True, 10:03:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:03:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:27 INFO - 'work_dir': 'build'} 10:03:27 INFO - ##### 10:03:27 INFO - ##### Running clobber step. 10:03:27 INFO - ##### 10:03:27 INFO - Running pre-action listener: _resource_record_pre_action 10:03:27 INFO - Running main action method: clobber 10:03:27 INFO - rmtree: /builds/slave/test/build 10:03:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:03:27 INFO - Running post-action listener: _resource_record_post_action 10:03:27 INFO - ##### 10:03:27 INFO - ##### Finished clobber step (success) 10:03:27 INFO - ##### 10:03:27 INFO - ##### 10:03:27 INFO - ##### Running read-buildbot-config step. 10:03:27 INFO - ##### 10:03:27 INFO - Running pre-action listener: _resource_record_pre_action 10:03:27 INFO - Running main action method: read_buildbot_config 10:03:27 INFO - Using buildbot properties: 10:03:27 INFO - { 10:03:27 INFO - "project": "", 10:03:27 INFO - "product": "firefox", 10:03:27 INFO - "script_repo_revision": "production", 10:03:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:03:27 INFO - "repository": "", 10:03:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:03:27 INFO - "buildid": "20160614073236", 10:03:27 INFO - "pgo_build": "True", 10:03:27 INFO - "basedir": "/builds/slave/test", 10:03:27 INFO - "buildnumber": 701, 10:03:27 INFO - "slavename": "talos-linux64-ix-013", 10:03:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:03:27 INFO - "platform": "ubuntu64_hw", 10:03:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:03:27 INFO - "branch": "mozilla-inbound", 10:03:27 INFO - "repo_path": "integration/mozilla-inbound", 10:03:27 INFO - "revision": "b1e2e1c0e5912f7ad331950b63871a72ac2807a5", 10:03:27 INFO - "stage_platform": "linux64-pgo", 10:03:27 INFO - "builduid": "387f0a94260c46568fbad355806b489e", 10:03:27 INFO - "slavebuilddir": "test" 10:03:27 INFO - } 10:03:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:03:27 INFO - Running post-action listener: _resource_record_post_action 10:03:27 INFO - ##### 10:03:27 INFO - ##### Finished read-buildbot-config step (success) 10:03:27 INFO - ##### 10:03:27 INFO - ##### 10:03:27 INFO - ##### Running download-and-extract step. 10:03:27 INFO - ##### 10:03:27 INFO - Running pre-action listener: _resource_record_pre_action 10:03:27 INFO - Running main action method: download_and_extract 10:03:27 INFO - mkdir: /builds/slave/test/build/tests 10:03:27 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')]} 10:03:27 INFO - https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:03:29 INFO - Downloaded 1361 bytes. 10:03:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:29 INFO - Using the following test package requirements: 10:03:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:03:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'jsshell-linux-x86_64.zip'], 10:03:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:03:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:03:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:29 INFO - https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:30 INFO - Downloaded 24221122 bytes. 10:03:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:03:31 INFO - Return code: 0 10:03:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:31 INFO - https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:34 INFO - Downloaded 24221122 bytes. 10:03:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:03:35 INFO - Return code: 0 10:03: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')]} 10:03:35 INFO - https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:03:37 INFO - Downloaded 14405384 bytes. 10:03:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:03:37 INFO - Return code: 0 10:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:37 INFO - https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:03:40 INFO - Downloaded 59375762 bytes. 10:03:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:40 INFO - mkdir: /builds/slave/test/properties 10:03:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:40 INFO - Contents: 10:03:40 INFO - build_url:https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:41 INFO - Running post-action listener: _resource_record_post_action 10:03:41 INFO - Running post-action listener: set_extra_try_arguments 10:03:41 INFO - ##### 10:03:41 INFO - ##### Finished download-and-extract step (success) 10:03:41 INFO - ##### 10:03:41 INFO - ##### 10:03:41 INFO - ##### Running populate-webroot step. 10:03:41 INFO - ##### 10:03:41 INFO - Running pre-action listener: _resource_record_pre_action 10:03:41 INFO - Running main action method: populate_webroot 10:03:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:41 INFO - '--tppagecycles', 10:03:41 INFO - '7'], 10:03:41 INFO - 'tests': ['tsvgm']}}, 10:03:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['damp', 'tps']}, 10:03:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'tests': ['damp', 'tps']}, 10:03:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['dromaeo_dom']}, 10:03:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['basic_compositor_video']}, 10:03:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['a11yr', 10:03:41 INFO - 'ts_paint', 10:03:41 INFO - 'tpaint', 10:03:41 INFO - 'sessionrestore', 10:03:41 INFO - 'sessionrestore_no_auto_restore', 10:03:41 INFO - 'tabpaint']}, 10:03:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['tsvgx', 10:03:41 INFO - 'tsvgr_opacity', 10:03:41 INFO - 'tart', 10:03:41 INFO - 'tscrollx', 10:03:41 INFO - 'cart']}, 10:03:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:41 INFO - 'tsvgr_opacity', 10:03:41 INFO - 'tart', 10:03:41 INFO - 'tscrollx', 10:03:41 INFO - 'cart']}, 10:03:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'talos_options': ['--disable-e10s'], 10:03:41 INFO - 'tests': ['tp5o']}, 10:03:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'tests': ['tp5o']}, 10:03:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'talos_options': ['--disable-e10s', 10:03:41 INFO - '--xperf_path', 10:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:41 INFO - 'tests': ['tp5n']}, 10:03:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:41 INFO - 'talos_options': ['--xperf_path', 10:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:41 INFO - 'tests': ['tp5n']}}, 10:03:41 INFO - 'talos.zip': {'path': '', 10:03:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:41 INFO - Running post-action listener: _resource_record_post_action 10:03:41 INFO - ##### 10:03:41 INFO - ##### Finished populate-webroot step (success) 10:03:41 INFO - ##### 10:03:41 INFO - ##### 10:03:41 INFO - ##### Running create-virtualenv step. 10:03:41 INFO - ##### 10:03:41 INFO - Running pre-action listener: _resource_record_pre_action 10:03:41 INFO - Running main action method: create_virtualenv 10:03:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:41 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 10:03:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:41 INFO - Using real prefix '/usr' 10:03:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:43 INFO - Installing pip.................done. 10:03:43 INFO - Return code: 0 10:03:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:43 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')]} 10:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:43 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')]} 10:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:03:43 INFO - Using env: {'DISPLAY': ':0', 10:03:43 INFO - 'HOME': '/home/cltbld', 10:03:43 INFO - 'LANG': 'en_US.UTF-8', 10:03:43 INFO - 'LANGUAGE': 'en_US:en', 10:03:43 INFO - 'LOGNAME': 'cltbld', 10:03:43 INFO - 'MAIL': '/var/mail/cltbld', 10:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:43 INFO - 'MOZ_NO_REMOTE': '1', 10:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:43 INFO - 'NO_EM_RESTART': '1', 10:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:43 INFO - 'PWD': '/builds/slave/test', 10:03:43 INFO - 'SHELL': '/bin/bash', 10:03:43 INFO - 'SHLVL': '1', 10:03:43 INFO - 'TERM': 'linux', 10:03:43 INFO - 'TMOUT': '86400', 10:03:43 INFO - 'USER': 'cltbld', 10:03:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:43 INFO - '_': '/tools/buildbot/bin/python'} 10:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:44 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 10:03:44 INFO - Cleaning up... 10:03:44 INFO - Return code: 0 10:03:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:44 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')]} 10:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 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')]} 10:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:03:44 INFO - Using env: {'DISPLAY': ':0', 10:03:44 INFO - 'HOME': '/home/cltbld', 10:03:44 INFO - 'LANG': 'en_US.UTF-8', 10:03:44 INFO - 'LANGUAGE': 'en_US:en', 10:03:44 INFO - 'LOGNAME': 'cltbld', 10:03:44 INFO - 'MAIL': '/var/mail/cltbld', 10:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:44 INFO - 'MOZ_NO_REMOTE': '1', 10:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:44 INFO - 'NO_EM_RESTART': '1', 10:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:44 INFO - 'PWD': '/builds/slave/test', 10:03:44 INFO - 'SHELL': '/bin/bash', 10:03:44 INFO - 'SHLVL': '1', 10:03:44 INFO - 'TERM': 'linux', 10:03:44 INFO - 'TMOUT': '86400', 10:03:44 INFO - 'USER': 'cltbld', 10:03:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:44 INFO - '_': '/tools/buildbot/bin/python'} 10:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:44 INFO - Downloading/unpacking psutil>=3.1.1 10:03:44 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 10:03:44 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 10:03:44 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 10:03:44 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 10:03:44 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 10:03:44 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 10:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:46 INFO - Installing collected packages: psutil 10:03:46 INFO - Running setup.py install for psutil 10:03:46 INFO - building 'psutil._psutil_linux' extension 10:03:46 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 10:03:46 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 10:03:46 INFO - building 'psutil._psutil_posix' extension 10:03:46 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 10:03:46 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 10:03:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:46 INFO - Successfully installed psutil 10:03:46 INFO - Cleaning up... 10:03:46 INFO - Return code: 0 10:03:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:03:46 INFO - Using env: {'DISPLAY': ':0', 10:03:46 INFO - 'HOME': '/home/cltbld', 10:03:46 INFO - 'LANG': 'en_US.UTF-8', 10:03:46 INFO - 'LANGUAGE': 'en_US:en', 10:03:46 INFO - 'LOGNAME': 'cltbld', 10:03:46 INFO - 'MAIL': '/var/mail/cltbld', 10:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:46 INFO - 'MOZ_NO_REMOTE': '1', 10:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:46 INFO - 'NO_EM_RESTART': '1', 10:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:46 INFO - 'PWD': '/builds/slave/test', 10:03:46 INFO - 'SHELL': '/bin/bash', 10:03:46 INFO - 'SHLVL': '1', 10:03:46 INFO - 'TERM': 'linux', 10:03:46 INFO - 'TMOUT': '86400', 10:03:46 INFO - 'USER': 'cltbld', 10:03:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:46 INFO - '_': '/tools/buildbot/bin/python'} 10:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:48 INFO - Installing collected packages: mozsystemmonitor 10:03:48 INFO - Running setup.py install for mozsystemmonitor 10:03:49 INFO - Successfully installed mozsystemmonitor 10:03:49 INFO - Cleaning up... 10:03:49 INFO - Return code: 0 10:03:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:49 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')]} 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:49 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')]} 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:03:49 INFO - Using env: {'DISPLAY': ':0', 10:03:49 INFO - 'HOME': '/home/cltbld', 10:03:49 INFO - 'LANG': 'en_US.UTF-8', 10:03:49 INFO - 'LANGUAGE': 'en_US:en', 10:03:49 INFO - 'LOGNAME': 'cltbld', 10:03:49 INFO - 'MAIL': '/var/mail/cltbld', 10:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:49 INFO - 'MOZ_NO_REMOTE': '1', 10:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:49 INFO - 'NO_EM_RESTART': '1', 10:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:49 INFO - 'PWD': '/builds/slave/test', 10:03:49 INFO - 'SHELL': '/bin/bash', 10:03:49 INFO - 'SHLVL': '1', 10:03:49 INFO - 'TERM': 'linux', 10:03:49 INFO - 'TMOUT': '86400', 10:03:49 INFO - 'USER': 'cltbld', 10:03:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:49 INFO - '_': '/tools/buildbot/bin/python'} 10:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:51 INFO - warning: no files found matching '*.txt' 10:03:51 INFO - no previously-included directories found matching 'build' 10:03:51 INFO - no previously-included directories found matching 'dist' 10:03:51 INFO - no previously-included directories found matching '.git*' 10:03:51 INFO - Installing collected packages: jsonschema, functools32 10:03:51 INFO - Running setup.py install for functools32 10:03:51 INFO - warning: no files found matching '*.txt' 10:03:51 INFO - no previously-included directories found matching 'build' 10:03:51 INFO - no previously-included directories found matching 'dist' 10:03:51 INFO - no previously-included directories found matching '.git*' 10:03:51 INFO - Successfully installed jsonschema functools32 10:03:51 INFO - Cleaning up... 10:03:51 INFO - Return code: 0 10:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03:51 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')]} 10:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:51 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')]} 10:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:03:51 INFO - Using env: {'DISPLAY': ':0', 10:03:51 INFO - 'HOME': '/home/cltbld', 10:03:51 INFO - 'LANG': 'en_US.UTF-8', 10:03:51 INFO - 'LANGUAGE': 'en_US:en', 10:03:51 INFO - 'LOGNAME': 'cltbld', 10:03:51 INFO - 'MAIL': '/var/mail/cltbld', 10:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:51 INFO - 'MOZ_NO_REMOTE': '1', 10:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:51 INFO - 'NO_EM_RESTART': '1', 10:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:51 INFO - 'PWD': '/builds/slave/test', 10:03:51 INFO - 'SHELL': '/bin/bash', 10:03:51 INFO - 'SHLVL': '1', 10:03:51 INFO - 'TERM': 'linux', 10:03:51 INFO - 'TMOUT': '86400', 10:03:51 INFO - 'USER': 'cltbld', 10:03:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:51 INFO - '_': '/tools/buildbot/bin/python'} 10:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:51 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 10:03:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:54 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 10:03:54 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 10:03:54 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 10:03:54 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 10:03:54 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 10:03:54 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 10:03:54 INFO - Downloading docopt-0.6.1.tar.gz 10:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:54 INFO - Running setup.py install for blobuploader 10:03:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:54 INFO - Running setup.py install for requests 10:03:54 INFO - Running setup.py install for docopt 10:03:55 INFO - Successfully installed blobuploader requests docopt 10:03:55 INFO - Cleaning up... 10:03:55 INFO - Return code: 0 10:03:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:03:55 INFO - Using env: {'DISPLAY': ':0', 10:03:55 INFO - 'HOME': '/home/cltbld', 10:03:55 INFO - 'LANG': 'en_US.UTF-8', 10:03:55 INFO - 'LANGUAGE': 'en_US:en', 10:03:55 INFO - 'LOGNAME': 'cltbld', 10:03:55 INFO - 'MAIL': '/var/mail/cltbld', 10:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:55 INFO - 'MOZ_NO_REMOTE': '1', 10:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:55 INFO - 'NO_EM_RESTART': '1', 10:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:55 INFO - 'PWD': '/builds/slave/test', 10:03:55 INFO - 'SHELL': '/bin/bash', 10:03:55 INFO - 'SHLVL': '1', 10:03:55 INFO - 'TERM': 'linux', 10:03:55 INFO - 'TMOUT': '86400', 10:03:55 INFO - 'USER': 'cltbld', 10:03:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:55 INFO - '_': '/tools/buildbot/bin/python'} 10:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:55 INFO - Running setup.py (path:/tmp/pip-G4v1lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:55 INFO - Running setup.py (path:/tmp/pip-lg2JHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:55 INFO - Running setup.py (path:/tmp/pip-tyBCM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:55 INFO - Running setup.py (path:/tmp/pip-P2Qd8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:55 INFO - Running setup.py (path:/tmp/pip-gi_4HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:55 INFO - Running setup.py (path:/tmp/pip-DGzFYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:55 INFO - Running setup.py (path:/tmp/pip-hZYbor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:55 INFO - Running setup.py (path:/tmp/pip-jYPLl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:55 INFO - Running setup.py (path:/tmp/pip-Sr3_na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:55 INFO - Running setup.py (path:/tmp/pip-OWfff0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:56 INFO - Running setup.py (path:/tmp/pip-NjCHJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:56 INFO - Running setup.py (path:/tmp/pip-hRao2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:56 INFO - Running setup.py (path:/tmp/pip-qjJPlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:56 INFO - Running setup.py (path:/tmp/pip-J6dJcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:56 INFO - Running setup.py (path:/tmp/pip-Jdkns4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:56 INFO - Running setup.py (path:/tmp/pip-1vFg1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:56 INFO - Running setup.py (path:/tmp/pip-xaY5NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:56 INFO - Running setup.py install for manifestparser 10:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:56 INFO - Running setup.py install for mozcrash 10:03:56 INFO - Running setup.py install for mozdebug 10:03:56 INFO - Running setup.py install for mozdevice 10:03:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozfile 10:03:57 INFO - Running setup.py install for mozhttpd 10:03:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozinfo 10:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozInstall 10:03:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozleak 10:03:57 INFO - Running setup.py install for mozlog 10:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for moznetwork 10:03:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozprocess 10:03:57 INFO - Running setup.py install for mozprofile 10:03:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:57 INFO - Running setup.py install for mozrunner 10:03:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:58 INFO - Running setup.py install for mozscreenshot 10:03:58 INFO - Running setup.py install for moztest 10:03:58 INFO - Running setup.py install for mozversion 10:03:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:58 INFO - Cleaning up... 10:03:58 INFO - Return code: 0 10:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:58 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')]} 10:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:58 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')]} 10:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:03:58 INFO - Using env: {'DISPLAY': ':0', 10:03:58 INFO - 'HOME': '/home/cltbld', 10:03:58 INFO - 'LANG': 'en_US.UTF-8', 10:03:58 INFO - 'LANGUAGE': 'en_US:en', 10:03:58 INFO - 'LOGNAME': 'cltbld', 10:03:58 INFO - 'MAIL': '/var/mail/cltbld', 10:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:58 INFO - 'MOZ_NO_REMOTE': '1', 10:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:58 INFO - 'NO_EM_RESTART': '1', 10:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:58 INFO - 'PWD': '/builds/slave/test', 10:03:58 INFO - 'SHELL': '/bin/bash', 10:03:58 INFO - 'SHLVL': '1', 10:03:58 INFO - 'TERM': 'linux', 10:03:58 INFO - 'TMOUT': '86400', 10:03:58 INFO - 'USER': 'cltbld', 10:03:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:58 INFO - '_': '/tools/buildbot/bin/python'} 10:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:58 INFO - Running setup.py (path:/tmp/pip-EEkBwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:58 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)) 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:58 INFO - Running setup.py (path:/tmp/pip-iqisOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:58 INFO - Running setup.py (path:/tmp/pip-kfNnTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:58 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)) 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:58 INFO - Running setup.py (path:/tmp/pip-rAUdZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:58 INFO - Running setup.py (path:/tmp/pip-eAVxM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:58 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)) 10:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:58 INFO - Running setup.py (path:/tmp/pip-Z8SCBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:59 INFO - Running setup.py (path:/tmp/pip-fVVm6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:59 INFO - Running setup.py (path:/tmp/pip-yD2GDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:59 INFO - Running setup.py (path:/tmp/pip-MHkAzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:59 INFO - Running setup.py (path:/tmp/pip-JrqEZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:59 INFO - Running setup.py (path:/tmp/pip-FR7BrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:59 INFO - Running setup.py (path:/tmp/pip-AftJee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:59 INFO - Running setup.py (path:/tmp/pip-sPUsbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:59 INFO - Running setup.py (path:/tmp/pip-jX7KfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:59 INFO - Running setup.py (path:/tmp/pip-NvgZeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:59 INFO - Running setup.py (path:/tmp/pip-CbbTCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:59 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)) 10:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:59 INFO - Running setup.py (path:/tmp/pip-kx4q5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:59 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)) 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:03:59 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)) 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:01 INFO - Downloading blessings-1.6.tar.gz 10:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:01 INFO - Installing collected packages: blessings 10:04:01 INFO - Running setup.py install for blessings 10:04:01 INFO - Successfully installed blessings 10:04:01 INFO - Cleaning up... 10:04:02 INFO - Return code: 0 10:04:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:02 INFO - Reading from file tmpfile_stdout 10:04:02 INFO - Current package versions: 10:04:02 INFO - argparse == 1.2.1 10:04:02 INFO - blessings == 1.6 10:04:02 INFO - blobuploader == 1.2.4 10:04:02 INFO - docopt == 0.6.1 10:04:02 INFO - functools32 == 3.2.3-2 10:04:02 INFO - jsonschema == 2.5.1 10:04:02 INFO - manifestparser == 1.1 10:04:02 INFO - mozInstall == 1.12 10:04:02 INFO - mozcrash == 0.17 10:04:02 INFO - mozdebug == 0.1 10:04:02 INFO - mozdevice == 0.48 10:04:02 INFO - mozfile == 1.2 10:04:02 INFO - mozhttpd == 0.7 10:04:02 INFO - mozinfo == 0.9 10:04:02 INFO - mozleak == 0.1 10:04:02 INFO - mozlog == 3.2 10:04:02 INFO - moznetwork == 0.27 10:04:02 INFO - mozprocess == 0.22 10:04:02 INFO - mozprofile == 0.28 10:04:02 INFO - mozrunner == 6.11 10:04:02 INFO - mozscreenshot == 0.1 10:04:02 INFO - mozsystemmonitor == 0.3 10:04:02 INFO - moztest == 0.7 10:04:02 INFO - mozversion == 1.4 10:04:02 INFO - psutil == 3.1.1 10:04:02 INFO - requests == 1.2.3 10:04:02 INFO - wsgiref == 0.1.2 10:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:02 INFO - Using env: {'DISPLAY': ':0', 10:04:02 INFO - 'HOME': '/home/cltbld', 10:04:02 INFO - 'LANG': 'en_US.UTF-8', 10:04:02 INFO - 'LANGUAGE': 'en_US:en', 10:04:02 INFO - 'LOGNAME': 'cltbld', 10:04:02 INFO - 'MAIL': '/var/mail/cltbld', 10:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:02 INFO - 'MOZ_NO_REMOTE': '1', 10:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:02 INFO - 'NO_EM_RESTART': '1', 10:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:02 INFO - 'PWD': '/builds/slave/test', 10:04:02 INFO - 'SHELL': '/bin/bash', 10:04:02 INFO - 'SHLVL': '1', 10:04:02 INFO - 'TERM': 'linux', 10:04:02 INFO - 'TMOUT': '86400', 10:04:02 INFO - 'USER': 'cltbld', 10:04:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:04:02 INFO - Cleaning up... 10:04:02 INFO - Return code: 0 10:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:04:02 INFO - Using env: {'DISPLAY': ':0', 10:04:02 INFO - 'HOME': '/home/cltbld', 10:04:02 INFO - 'LANG': 'en_US.UTF-8', 10:04:02 INFO - 'LANGUAGE': 'en_US:en', 10:04:02 INFO - 'LOGNAME': 'cltbld', 10:04:02 INFO - 'MAIL': '/var/mail/cltbld', 10:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:02 INFO - 'MOZ_NO_REMOTE': '1', 10:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:02 INFO - 'NO_EM_RESTART': '1', 10:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:02 INFO - 'PWD': '/builds/slave/test', 10:04:02 INFO - 'SHELL': '/bin/bash', 10:04:02 INFO - 'SHLVL': '1', 10:04:02 INFO - 'TERM': 'linux', 10:04:02 INFO - 'TMOUT': '86400', 10:04:02 INFO - 'USER': 'cltbld', 10:04:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:04:02 INFO - Cleaning up... 10:04:02 INFO - Return code: 0 10:04:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd404124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', '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 10:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:04:02 INFO - Using env: {'DISPLAY': ':0', 10:04:02 INFO - 'HOME': '/home/cltbld', 10:04:02 INFO - 'LANG': 'en_US.UTF-8', 10:04:02 INFO - 'LANGUAGE': 'en_US:en', 10:04:02 INFO - 'LOGNAME': 'cltbld', 10:04:02 INFO - 'MAIL': '/var/mail/cltbld', 10:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:02 INFO - 'MOZ_NO_REMOTE': '1', 10:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:02 INFO - 'NO_EM_RESTART': '1', 10:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:02 INFO - 'PWD': '/builds/slave/test', 10:04:02 INFO - 'SHELL': '/bin/bash', 10:04:02 INFO - 'SHLVL': '1', 10:04:02 INFO - 'TERM': 'linux', 10:04:02 INFO - 'TMOUT': '86400', 10:04:02 INFO - 'USER': 'cltbld', 10:04:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:02 INFO - Downloading/unpacking flake8 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:04:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:04:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:05 INFO - no previously-included directories found matching 'docs/_build' 10:04:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:04:05 INFO - Running setup.py install for pep8 10:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:05 INFO - no previously-included directories found matching 'docs/_build' 10:04:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:04:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:04:05 INFO - Cleaning up... 10:04:05 INFO - Return code: 0 10:04:05 INFO - Running post-action listener: _resource_record_post_action 10:04:05 INFO - Running post-action listener: _start_resource_monitoring 10:04:05 INFO - Starting resource monitoring. 10:04:05 INFO - ##### 10:04:05 INFO - ##### Finished create-virtualenv step (success) 10:04:05 INFO - ##### 10:04:05 INFO - ##### 10:04:05 INFO - ##### Running install step. 10:04:05 INFO - ##### 10:04:05 INFO - Running pre-action listener: _resource_record_pre_action 10:04:05 INFO - Running main action method: install 10:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:05 INFO - Reading from file tmpfile_stdout 10:04:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:06 INFO - Reading from file tmpfile_stdout 10:04:06 INFO - Output received: 10:04:06 INFO - Usage: mozinstall [options] installer 10:04:06 INFO - Options: 10:04:06 INFO - -h, --help show this help message and exit 10:04:06 INFO - -d DEST, --destination=DEST 10:04:06 INFO - Directory to install application into. [default: 10:04:06 INFO - "/builds/slave/test"] 10:04:06 INFO - --app=APP Application being installed. [default: firefox] 10:04:06 INFO - mkdir: /builds/slave/test/build/application 10:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:04:22 INFO - Reading from file tmpfile_stdout 10:04:22 INFO - Output received: 10:04:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:22 INFO - Running post-action listener: _resource_record_post_action 10:04:22 INFO - ##### 10:04:22 INFO - ##### Finished install step (success) 10:04:22 INFO - ##### 10:04:22 INFO - ##### 10:04:22 INFO - ##### Running run-tests step. 10:04:22 INFO - ##### 10:04:22 INFO - Running pre-action listener: _resource_record_pre_action 10:04:22 INFO - Running main action method: run_tests 10:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:22 INFO - Python 2.7.3 10:04:22 INFO - Return code: 0 10:04:22 INFO - grabbing minidump binary from tooltool 10:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:22 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15102e0>, '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 0x147c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:22 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 10:04:22 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 10:04:22 INFO - Calling ['/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'] with output_timeout 600 10:04:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:23 INFO - Return code: 0 10:04:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:04:23 INFO - Return code: 0 10:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:04:23 INFO - Using env: {'DISPLAY': ':0', 10:04:23 INFO - 'HOME': '/home/cltbld', 10:04:23 INFO - 'LANG': 'en_US.UTF-8', 10:04:23 INFO - 'LANGUAGE': 'en_US:en', 10:04:23 INFO - 'LOGNAME': 'cltbld', 10:04:23 INFO - 'MAIL': '/var/mail/cltbld', 10:04:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:23 INFO - 'MOZ_NO_REMOTE': '1', 10:04:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:23 INFO - 'NO_EM_RESTART': '1', 10:04:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:23 INFO - 'PWD': '/builds/slave/test', 10:04:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:23 INFO - 'SHELL': '/bin/bash', 10:04:23 INFO - 'SHLVL': '1', 10:04:23 INFO - 'TERM': 'linux', 10:04:23 INFO - 'TMOUT': '86400', 10:04:23 INFO - 'USER': 'cltbld', 10:04:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341', 10:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:23 INFO - '_': '/tools/buildbot/bin/python'} 10:04:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:04:24 INFO - mozversion application_buildid: 20160614073236 10:04:24 INFO - mozversion application_changeset: b1e2e1c0e5912f7ad331950b63871a72ac2807a5 10:04:24 INFO - mozversion application_display_name: Nightly 10:04:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:24 INFO - mozversion application_name: Firefox 10:04:24 INFO - mozversion application_remotingname: firefox 10:04:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:04:24 INFO - mozversion application_vendor: Mozilla 10:04:24 INFO - mozversion application_version: 50.0a1 10:04:24 INFO - mozversion platform_buildid: 20160614073236 10:04:24 INFO - mozversion platform_changeset: b1e2e1c0e5912f7ad331950b63871a72ac2807a5 10:04:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:04:24 INFO - mozversion platform_version: 50.0a1 10:04:24 INFO - using testdate: 1465923864 10:04:24 INFO - actual date: 1465923864 10:04:24 INFO - starting webserver on 'localhost:60645' 10:04:24 INFO - SUITE-START | Running 2 tests 10:04:24 INFO - TEST-START | dromaeo_css 10:04:24 INFO - operating with platform_type : linux_ 10:04:24 INFO - Initialising browser for dromaeo_css test... 10:04:24 INFO - TEST-INFO | started process 4868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Fcujb/profile http://localhost:60645/getInfo.html) 10:04:29 INFO - PROCESS | 4868 | __metrics Screen width/height:1600/1200 10:04:29 INFO - PROCESS | 4868 | colorDepth:24 10:04:29 INFO - PROCESS | 4868 | Browser inner width/height: 1024/697 10:04:29 INFO - PROCESS | 4868 | __metrics 10:04:29 ERROR - PROCESS | 4868 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:04:30 INFO - TEST-INFO | 4868: exit 0 10:04:30 INFO - Browser initialized. 10:04:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:30 INFO - TEST-INFO | started process 4989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Fcujb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:42 INFO - PROCESS | 4989 | RSS: Main: 185131008 10:04:42 INFO - PROCESS | 4989 | 10:05:32 INFO - PROCESS | 4989 | 1465923932212 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] 10:07:40 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60645/tests/dromaeo/cssquery-ext.html) 10:07:41 INFO - PROCESS | 4989 | RSS: Main: 189149184 10:07:41 INFO - PROCESS | 4989 | 10:10:43 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-ext.html (next: http://localhost:60645/tests/dromaeo/cssquery-jquery.html) 10:10:44 INFO - PROCESS | 4989 | RSS: Main: 188063744 10:10:44 INFO - PROCESS | 4989 | 10:13:45 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60645/tests/dromaeo/cssquery-mootools.html) 10:13:46 INFO - PROCESS | 4989 | RSS: Main: 189349888 10:13:46 INFO - PROCESS | 4989 | 10:16:48 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60645/tests/dromaeo/cssquery-prototype.html) 10:16:48 INFO - PROCESS | 4989 | RSS: Main: 186617856 10:16:48 INFO - PROCESS | 4989 | 10:19:51 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60645/tests/dromaeo/cssquery-yui.html) 10:19:51 INFO - PROCESS | 4989 | RSS: Main: 188866560 10:19:51 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | Cycle 1(1): loaded http://localhost:60645/tests/dromaeo/cssquery-yui.html (next: http://localhost:60645/tests/dromaeo/cssquery-dojo.html) 10:22:54 INFO - PROCESS | 4989 | RSS: Main: 190083072 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | __start_tp_report 10:22:54 INFO - PROCESS | 4989 | _x_x_mozilla_page_load 10:22:54 INFO - PROCESS | 4989 | _x_x_mozilla_page_load_details 10:22:54 INFO - PROCESS | 4989 | |i|pagename|runs| 10:22:54 INFO - PROCESS | 4989 | |0;dojo.html;3069.508878579427;3090.119315994942;3141.5758872552196;3144.4025635129315;3168.8890888818896;5400.000999815032;5407.540359069474;5439.102548079567;5504.036793561131;5522.91715624266;5239.266502689627;5375.919361209585;5408.729563521828;5430.83707488776;5462.071447853865;4888.07126645937;4910.06708725341;5015.824446144386;5047.621428392885;5100.923486147711;4898.804047838083;5122.282880396748;5155.587552995751;5156.046131465672;5169.534741873231;4799.232122860343;4857.222844344923;4870;4977.776000079987;4983.028309479635;4897.33885925399;4900.926486102711;4902.950970490285;4915.729634870081;4936.605071594264;4866.8806174579695;4871.732054736988;4876.414830220361;4886.9511304886855;4908.435529914034;5210.791568337262;5307.389650190239;5374.032674118657;5434.266374039494;5454.972725136349;5771.826845194651;5772.393898640625;5804.158397032406;5811.244538210048;5817.447342502455;5562.082256427685;5804.65172089676;5809.157672137517;5821.79623713168;5833.7083145842535;5443.945560544384;5451.48210919962;5496.532794712454;5530.972345138329;5548.667079975174;6024.909626355608;6028.939710602838;6033.9698301508215;6036.215292012011;6040.969795150996;5455.8363249102595;5655.3779084300695;5754.510866576305;5773.076307790818;5809.854753631109;5795.797147099831;5817.825465236049;5828.6502809831545;5847.298324201123;5909.911351329733;5489.560835133179;5688.089905615082;5805.245318108618;5806.593538452268;5822.097574875901;5510.035743744828;5711.200431939532;5771.653700777967;5794.88410231793;5862.384449632812;4367.672424568106;4379.233634114081;4392.033752574429;4401.339799030171;4420.845270415584;3920.6079392060565;3928.5678575356687;3938.8818335449982;3969.8412063517712;3973.0663294125857;5500.22996780451;5504.284443022381;5507.981023510663;5530.6128571000445;5583.860403489864;5873.3832947539895;5881.235439392852;5897.64614123154;5915.231019967377;5940.227770389822;5630.943690563124;5640.069388550925;5649.915251271234;5653;5653.858653533613;4884.389451318585;5033.5721463676;5042.520960508746;5057.089723849743;5112;6027.969860150672;6044.7582096716515;6045.758169673164;6052.606580572248;6073.362296958844;5889.146073819272;5894.440028197314;5897.203877476486;5903.645781253139;5912.881742365214;5774.94225057744;5926.1999630049395;5931.970340148272;5982.102684597346;6017.849553761191;5713.857153571194;5722.456366645162;5727.942720572908;5729.1119876419225;5739.5695322850115;5609.074502707008;5806.622569532967;5826.679532625746;5828.59199856006;5837.6497410155525;5561.221429000024;5574.191742197439;5617.775288988395;5635.351934527418;5640.915386269127;5557.916631250615;5559.19391688211;5566.387697353207;5611.607187496836;5649.661020338793;5487.396386397573;5575.860603484945;5576.163575463713;5588.552915766811;5595.8880822384135;5449.427810079885;5548.833534993957;5564.860878478071;5628.437156284503;5634.535020894515;5513.090340094;5514.779408823602;5532;5556.666600004012;5592.356878958972 10:22:54 INFO - PROCESS | 4989 | |1;ext.html;589.0486863715099;606.5026678123941;627.1502114634669;649.7303618998114;658.8616390557983;39561.80219098904;43080.78459607698;43425;43464.78267608657;43481.34777978329;42542;43240;43285.7835710821;43431.13137737243;43473;8807.207351338378;8864.512451815148;8877.866831997526;8945.64217431302;8953.910460895406;8731.694390696326;8904.065073167321;8907.421017633866;8921.643134274622;8972.192502674758;8911.598978045971;8953.865692014626;8987;9012.41419307743;9035.864462033074;8892.866607000868;8915.331350148765;8919.197272245465;8933.419327743675;8940.73177804667;8739.951205855274;8842.911570884273;8846.911530884674;8864.955675221583;8920.330975176823;40909.79545102285;41041.58958410408;41658;41732.79133604343;41746.373804392955;2928.2532954096782;3391.2369716813764;3413.8805141820167;3418.9487157692656;3452.4130897747445;30978.84510577455;31756.841215793775;31759.364812703847;31793.205169870707;31998.20004499883;4113.691473139526;4220.85227017053;4237.470316210473;4270.167317373113;4398.142362239365;294957;295601;297934;298227;300309;34133.48799768005;34535;34545.65454345424;34607.4808877867;35551.82224088863;36562.63437365645;36671.633283667354;36715.449268261;36732.44901326482;36776.448353274725;12984.610461686165;13013.869861301455;13021.414036368385;13026.609201723963;13103.60689179326;12269.570565030359;12298.20061695987;12350.197237179555;12443.813342799865;12494.500219991098;8217.383696222807;8307.709230176915;8337.166283371615;8412.747617571482;8439.535825529654;3189.091109033914;3190.6330771961057;3220.5813244278092;3295.385261221984;3296;898.384606544506;1024.9180065594735;1048.8112139814907;1052.8052310322614;1152.504423098059;32731.836340818143;33096;33319.333613327595;33360;33475.49786753201;1019.5259204469809;1079.5897558927556;1080.6325849211305;1089.455272363818;1094.2777766673958;15939.282732277075;16147.515574532548;16288.918555407146;16817.663646726996;16846.41037563704;608338;610340.4829758494;611157;613939;615934;56852.43147568554;58379;58483;58484;58616;1310.8033794930645;1325.1254172246463;1335.0921373466135;1344.798280257969;1352.114365090867;29917.252068698457;30999;31335.84332078325;31796.205094871886;32144.67855321417;49149.262761059326;49920;50023;50323.74838125786;50381.49618503915;441788.3284668577;443087;443691;444689;445007;27732.44535109246;28059.298517537223;28110.2972425691;28275.858620707586;28730.856345718137;48410.5158948406;48694.75652621714;48721;48872.51127488822;48973;41766.5583604099;42004.3699344504;42257.366139507314;42419.57580424156;42875;40990.590094098676;41039.794801027;41078.58921410747;41475.1704965905;41635.37546936859;36612.81693591621;40760.184796303314;41235.175296494504;41564;41600.791996041036;32382.19044523906;37345.626543734215;37669.7980671646;37956.620433796415;38136;28296.08673267914;28706;28868.711312886604;28895.56656650194;29033.499807529868 10:22:54 INFO - PROCESS | 4989 | |2;jquery.html;377.79032636886535;379.8822365066828;386.56125297787014;393.64768532163714;399.67825900150365;15434.922825385886;17407.912960435195;18801.623967520674;20348.1860725571;20381.898090509545;18788.53028674284;19216.42350729477;19982.100805463753;20053.59892802143;20127.59744805103;5279.313689220415;5492.752826122834;5594.0769772987405;5597.852440249739;5639.6334238274585;5422.132458806592;5517;5736.6558006519535;5739.081746920494;5742.569307301948;5689.358442514484;5716.1997320375185;5738.282714660668;6289.182406287199;6337.493000559944;5753.597248192628;5974.880502389971;6316.178896743417;6316.621002739827;6325.1777268954975;5498.147787093007;5509.917351239735;5519.806806761744;5530.115181570929;5545.390007099216;13801.861981380158;18253.087345632797;21456.463588410257;22957.311280661608;23037;2266.331432227497;2270.5685919675375;2347.788699017097;2490.452100537879;2680.209338245222;9613.855792163124;9765.90234097657;9820.067093626094;10094.49527523621;10344.5344959477;1927.3254360973688;1993.1728332742039;2001.329554599211;2035.877847329165;2043.438054535;55220.72389638026;82586.58706706428;83267.5836620813;83685;84330.15669843284;10318;10375.740606484747;10560.419176945188;10703.19726020536;10730.94634526838;12165.513379464723;13172.07795454309;14061.226632535308;14539.85460145385;14555.05392149507;7506.512076714996;7571.697132114654;7697.153313135551;7789.64946577394;7837.960810196027;7408.592527411044;7425.368843648243;7461.291177338144;7566.621668916532;7572.356349710336;4407.889802754893;4408.58118478744;4409.492908315585;4425.955740442554;4568.109218702388;1855.6103218324033;1897.459224121119;1922.09661459114;1934.35199208264;1945.6206039822098;921.6267411698273;1006.2553710254359;1025.2003437318904;1088.0914436445657;1122.3434290939729;18835.340763073225;19312.517187070436;19316.71024934627;19364.806351936582;19499.122539485757;977.9364341317792;996.4121168510469;1010.722051435861;1044.921630877672;1096.780643871213;10163.94918025405;10780;10807.351558906334;10813.891861081445;10846.132309415229;444732;448469;514435;515700;530290;82692.58653706693;85188;85480.14519854846;97998;101367.49316253519;970.9174720148725;1018.0786388318436;1020.831562792131;1021.9131373833308;1039.7868436970402;17914.193861276013;18057.63884722272;18100.72848907294;18181.727274090634;18318.08409579489;40104.598954010085;41378.586214138675;41450.170996580506;41798.1640367197;42983.570164299206;57548.71225643845;58738.70630646819;58976.41023589881;59277;59573.7021314908;8419.70531031411;8515.74452766418;8556.957215213884;8673.176048275403;8673.783155421164;9548.85676714836;12646.557370491988;13018.414171362121;13430.19418834873;13830;11679.357635330138;11687.88312116902;11740.295582265091;11947.641570752892;12001.099917506048;11316.321020738782;11499.13756468285;11826.82259766087;11858.822117668415;12111.333876636518;11404.144689148181;11678.182527223013;11891.583794567148;11986.64040078799;12003.579874704343;7004.859902802017;7417.147028091838;8477;8530.829383412422;8573.485590864568;11449.313041217554;11977.221480603734;12163.2702037878;12182.147249692436;12362.629121126382 10:22:54 INFO - PROCESS | 4989 | |3;mootools.html;1374.2166964830046;1393.0457636518986;1531.8085239345082;1734.6964281250778;1749.396458221913;7213.711451541932;8493.108223636515;8521.44610600312;9160.816783664332;9173.128552787482;8357.20606542379;8555.315574754004;8557.828843423144;8618.052014278424;8710.346723995694;2260.2315212827634;2299.8850057497143;2305.0549274797336;2305.227748704186;2306.5041016181517;2211.7788221177916;2229.57638048771;2258.4692597239637;2260.581792368409;2265.3770213191337;2292.2893902890073;2302.2172461363134;2325.3140323604575;2340.9297721068397;2346.894389752457;2202.570498752744;2202.647576387786;2211.5466329402434;2217.401301648562;2219.933401997943;2161.6217161996747;2173.4566358410398;2173.7065496158134;2174.412908514708;2176.183931025865;8926.910730892672;8938.46369217849;9019.909800901973;9027.05215952322;9041.909580904172;5152.690838549662;5252.23842542833;5252.947470525322;5282.524572788468;5284.973575132138;3038.2404398900276;3121.812691238533;3170.4451720948973;3259.5925509311337;3277.246233366315;1058.8147074262051;1073.7154654016692;1081.3998230981801;1103.9227254092136;1114.2645853736494;12513.624591262276;12598.74802503954;12632.30522321272;12649.304288264142;12651.177673451197;4519.344695019204;4616.699914505546;4655.580997710223;4710.387649605598;4734.668573199911;10415.323004004867;10432.530536125892;10446.477676116316;10453.68638940833;10474.319169253975;5223.112070947948;5244.9737751310995;5254;5256.789728410898;5262.894742105136;4081.959180408158;4752.7861246244;4766.189747742892;4823.9517604824205;4922.114019476457;3923.489946306962;3965.4448377227213;3992.940105898414;4052;4163.208990291835;1242.931638759877;1252.3362617812575;1261.7161138743893;1285.3830161522521;1290.2709968867748;983.9950800246096;1020.9897901021043;1023.3501726403787;1030.7320096774743;1040.266612038511;6181.426963673925;6228.439440450381;6256.468200203034;6370.8088757337355;6462.3537646235;433.3910855248318;440.0626665203097;440.4384409877432;443.01650336253465;444.90212153326866;4384.583464570861;4416.646668266531;4459.241928872035;4478.462584489882;4490.820367185276;10800.945995269973;11042.779144417227;11194.272372295774;11221.438928053565;11237.04485118774;10514.316569422963;10860.239783215256;10942.835857462145;11240.775184496428;11264.493097810619;7896.921030789734;8188.50868947865;8199.344052475788;8201.71294004707;8209.384296177692;6063.909041364295;6349.619022858643;6397.072424498515;6470.514711396759;6496.960486322166;10055.597776088875;10181.981801819758;10191.082802547806;10251.84622230682;10385.532651030873;10290.434026128336;10395.792084158124;10435.530401131815;10445.738856528647;10488.895111048792;6816.454683625398;7698.114716807639;8025.558594277138;8033.116357200586;8211.917880821115;8668.263197628272;8703.390762646553;8754;8763.298936085226;8795.208431241219;7442.479026468095;7443;7601.315881570686;7750.0699916010435;8070.87893681607;7372.152202496782;7495.1005879294835;7616.162222155669;7654.2345765423015;7696.961515192388;6962.686679099352;7035.718571257297;7048.118985126859;7050.365467107985;7054.153501579844;5216.243644671577;5296.814611488579;5304.867378315419;5315.867103322448;5507.807226747044;5211.530962213419;5441.918371224514;5490.80782172622;5551.555875530029;5584.357798853184 10:22:54 INFO - PROCESS | 4989 | |4;prototype.html;310.79953430037625;316.67382595926205;318.2298836814907;328.9983550082249;332.82360349015033;5474.589405794572;5517.641353312042;5652.784651299975;5689.573282003851;5719.885602287952;5550.417206193352;5594.797118619496;5596.888062238752;5630.943690563104;5642.266505354309;4337.219300525896;4340.110277393127;4360.803763830635;4366.607005369516;4405.986623076678;4061.614146656063;4314.115606300701;4324.264874971247;4369;4392.3191905254735;4275.593818587229;4276.315789473685;4276.636485898703;4278.315469524877;4292.699511034229;4305.0098477350075;4310.353446982962;4320.805563749639;4322.459692538433;4327.744953963347;3525.9294814103832;3761.570603170805;3764.1342491226897;3767.1335592813534;3769.981150094232;5449.536789372908;5463.617546771688;5516.8966206758805;5531.668099914018;5532.984523434738;4882.536159064884;4894.632902532324;4923.261510773377;4926.75366231687;4948;5582.8325150245555;5840.766369345263;5860.355360910296;5868.589198756089;5935.406459354073;4109.4246805447265;4130.772807495587;4144.72040377791;4151.14901445206;4174.186033723425;6148.108524264001;6154.522694677493;6160.969195154041;6218.378162183791;6236.251649802053;4096.09885825118;4191;4195.811188496525;4216.367544868294;4237.724547904377;4230.386593943861;4235.496398778451;4240.38514415408;4258.552851950562;4267.338562522814;4873.756312184448;4911.287863259808;4981.850544483599;4989.151844186497;4990.675606085593;5829.446202610745;5925.259342582177;5978.910316345258;6022.247219097613;6032.336442991267;1420.779779134236;1442.668186317132;1446.464808021018;1469.860363265488;1471.1026273972868;889.1863944490848;921.9723408297762;935.6257497001118;937.634322614181;944.9699827188398;5038.219076043146;5045.8738531537;5060;5110.233464980209;5112.412072611697;5380.515753582196;5431.375391829911;5433.375161856358;5439.972800135974;5455.945440545624;4878.755917241081;5058.83646761247;5072.376839411427;5105.289727941107;5115.1559992600805;2870.368518925833;2886.81640527387;2913.4027524357457;2914.2568644995813;2920.415916816645;5483.588730845203;5501;5541.5289700375915;5543.52880005204;5550.611457197957;5151.557563882119;5455.699936503531;5471.003083874357;5485.930243602459;5495.917561236504;5465.672059676433;5511.944880551223;5516.3380394352935;5524.779008839601;5538.6122971391615;5232.424433312256;5267.236250743697;5326;5387.542058925035;5402.486763757437;5368.416317186361;5372.516473517402;5386.814900721835;5394.460553944574;5411.863508663225;5412.43039518551;5471.823557935063;5482.369527504388;5588.708629461901;5971.671558064349;4081.2449696806184;4188.958110418978;4199.433076534751;4207.116505533872;4209.5790420957655;5990.071538911476;6067.696615169312;6071.301800293023;6151.292601350902;6165.84585385351;5646.88706225865;5834.7082645866685;5922.466977972003;5961.105834124916;5970.791022314198;5838.182654428469;5873.911891321719;5905.91141132892;5936.940630593639;5967.283925928917;5753.741081651252;5775.480206781242;5781.392953739797;5792.088610758524;5798.420157984337;5645.943540564542;5838.503727183067;5838.912416313674;5885.117232415172;5911;5805.158252053513;5821.27234095738;5840.795572154954;5842.065269556851;5859.853503662443 10:22:54 INFO - PROCESS | 4989 | |5;yui.html;655.0861548140348;655.6393983309179;729.711763853278;753.8416932444186;785.9607019649018;14058.648533786647;14471.276436178201;14515.637109072279;14518.854811451882;14629.634259143513;16110;16139.919300403511;16308.918455407706;16408;16442.917785411057;789.6722860013087;813.2477458351032;818.8689809630446;826.669332267095;827.3133299361516;828.0725587342155;832.9791755206107;835.2691395029349;835.5529791561515;838.8406202821444;846;847.1570787066877;850.3877208409934;850.9319254459659;856.87146927961;845.3110714767475;845.6194712379423;845.940784145107;846.3525403066659;849.8130411309502;614.4285814192799;615.1510914937403;617.9134921111048;618.5268269773627;618.7246675229525;15105.54683359501;15142.16718080505;15146.924265378713;15188.164650944194;15199.544013679497;14652.70694586113;14832.777508337384;14843.851561484464;14852.777208341884;14912.17983010934;12447.074937389707;12559.56041538551;12705.428255728515;12809.167404118702;13000;3799.563050249229;3914.7651140931353;3974.940375894364;4050.4734384530116;4085.346344584852;74461;76647.99999999945;77336;77630.22369776286;78840;11253;11323.207375483802;11568.074554035657;11570.537178512934;11971.341576213217;21285.255016074363;21342;21408.892955535124;21411.78588214098;21422.143114275565;8375.664973400995;8405;8515.14848515156;8515.14848515156;8818.559072046372;4582.679212455163;4673.813047478131;4768.642351823558;4777.976110119496;4846.151923413388;3427.451607742799;3541.4333706607335;3551.5560554930635;3555.7866528008403;3566.465030245484;592.9466348028698;619.9380061993854;623.370395900135;626.0984182776787;636.8949123394588;630.3224034163201;735.7125031195408;742.5359150530918;752.6312107067607;767.8848172774128;9703.805923881624;9906.653267135616;10124.139448146843;10129.645462408927;10208.846867296996;617.6726335042434;636.2810024672091;667.4893706314673;692.2350802363316;728.9671964761599;4708.9058218835435;4924.657500285087;4967.3542439482635;4974.552290293891;4982.501749824988;98395;102678.43303917462;102757;108407.45796270968;109031.45484272527;101990;102645.48677256715;103331;103332.48333758433;103889.48055259675;67602.66198668975;86891.56554217188;87365.99999999873;88099;89621.55189224012;9593.42439453635;9721.70834874955;9798.559064841957;9820.754481137743;9849.310548261554;51235;52039.479605203465;52317.73841130922;53994.730026349614;54220;66054.66972665106;67701.66149169223;74383;77530;77891;11122.666320010088;11270.267432616854;11317.943410283226;11329.773404532029;11999.220050696676;12973.156744811557;13002.73778593432;13013.544525941546;13063.542776002794;13192;12461.376931153225;12754.42605082755;12922.418491167731;12986.610401687965;13563.254021028544;11635;11702.122340824302;12137.579872204402;12496.562620308245;12801.231926084465;11103.666889993314;11386.829197562209;11543.365114918424;11656.941715291368;11744.76510469803;10346.376074005366;10499.790004200026;10556.683299501028;10634.627788027381;10818;10505;10960.739514955882;10978.615748448767;11070.723231919266;11150.776984460428 10:22:54 INFO - PROCESS | 4989 | __end_tp_report 10:22:54 INFO - PROCESS | 4989 | __start_cc_report 10:22:54 INFO - PROCESS | 4989 | _x_x_mozilla_cycle_collect,350 10:22:54 INFO - PROCESS | 4989 | __end_cc_report 10:22:54 INFO - PROCESS | 4989 | __startTimestamp1465924974922__endTimestamp 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | ------- Summary: start ------- 10:22:54 INFO - PROCESS | 4989 | Number of tests: 6 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#0] dojo.html Cycles:165 Average:5389.64 Median:5562.08 stddev:616.74 (11.1%) stddev-sans-first:591.17 10:22:54 INFO - PROCESS | 4989 | Values: 3069.5 3090.1 3141.6 3144.4 3168.9 5400.0 5407.5 5439.1 5504.0 5522.9 5239.3 5375.9 5408.7 5430.8 5462.1 4888.1 4910.1 5015.8 5047.6 5100.9 4898.8 5122.3 5155.6 5156.0 5169.5 4799.2 4857.2 4870.0 4977.8 4983.0 4897.3 4900.9 4903.0 4915.7 4936.6 4866.9 4871.7 4876.4 4887.0 4908.4 5210.8 5307.4 5374.0 5434.3 5455.0 5771.8 5772.4 5804.2 5811.2 5817.4 5562.1 5804.7 5809.2 5821.8 5833.7 5443.9 5451.5 5496.5 5531.0 5548.7 6024.9 6028.9 6034.0 6036.2 6041.0 5455.8 5655.4 5754.5 5773.1 5809.9 5795.8 5817.8 5828.7 5847.3 5909.9 5489.6 5688.1 5805.2 5806.6 5822.1 5510.0 5711.2 5771.7 5794.9 5862.4 4367.7 4379.2 4392.0 4401.3 4420.8 3920.6 3928.6 3938.9 3969.8 3973.1 5500.2 5504.3 5508.0 5530.6 5583.9 5873.4 5881.2 5897.6 5915.2 5940.2 5630.9 5640.1 5649.9 5653.0 5653.9 4884.4 5033.6 5042.5 5057.1 5112.0 6028.0 6044.8 6045.8 6052.6 6073.4 5889.1 5894.4 5897.2 5903.6 5912.9 5774.9 5926.2 5932.0 5982.1 6017.8 5713.9 5722.5 5727.9 5729.1 5739.6 5609.1 5806.6 5826.7 5828.6 5837.6 5561.2 5574.2 5617.8 5635.4 5640.9 5557.9 5559.2 5566.4 5611.6 5649.7 5487.4 5575.9 5576.2 5588.6 5595.9 5449.4 5548.8 5564.9 5628.4 5634.5 5513.1 5514.8 5532.0 5556.7 5592.4 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#1] ext.html Cycles:180 Average:59210.59 Median:41060.09 stddev:125296.10 (305.2%) stddev-sans-first:125570.28 10:22:54 INFO - PROCESS | 4989 | Values: 589.0 606.5 627.2 649.7 658.9 39561.8 43080.8 43425.0 43464.8 43481.3 42542.0 43240.0 43285.8 43431.1 43473.0 8807.2 8864.5 8877.9 8945.6 8953.9 8731.7 8904.1 8907.4 8921.6 8972.2 8911.6 8953.9 8987.0 9012.4 9035.9 8892.9 8915.3 8919.2 8933.4 8940.7 8740.0 8842.9 8846.9 8865.0 8920.3 40909.8 41041.6 41658.0 41732.8 41746.4 2928.3 3391.2 3413.9 3418.9 3452.4 30978.8 31756.8 31759.4 31793.2 31998.2 4113.7 4220.9 4237.5 4270.2 4398.1 294957.0 295601.0 297934.0 298227.0 300309.0 34133.5 34535.0 34545.7 34607.5 35551.8 36562.6 36671.6 36715.4 36732.4 36776.4 12984.6 13013.9 13021.4 13026.6 13103.6 12269.6 12298.2 12350.2 12443.8 12494.5 8217.4 8307.7 8337.2 8412.7 8439.5 3189.1 3190.6 3220.6 3295.4 3296.0 898.4 1024.9 1048.8 1052.8 1152.5 32731.8 33096.0 33319.3 33360.0 33475.5 1019.5 1079.6 1080.6 1089.5 1094.3 15939.3 16147.5 16288.9 16817.7 16846.4 608338.0 610340.5 611157.0 613939.0 615934.0 56852.4 58379.0 58483.0 58484.0 58616.0 1310.8 1325.1 1335.1 1344.8 1352.1 29917.3 30999.0 31335.8 31796.2 32144.7 49149.3 49920.0 50023.0 50323.7 50381.5 441788.3 443087.0 443691.0 444689.0 445007.0 27732.4 28059.3 28110.3 28275.9 28730.9 48410.5 48694.8 48721.0 48872.5 48973.0 41766.6 42004.4 42257.4 42419.6 42875.0 40990.6 41039.8 41078.6 41475.2 41635.4 36612.8 40760.2 41235.2 41564.0 41600.8 32382.2 37345.6 37669.8 37956.6 38136.0 28296.1 28706.0 28868.7 28895.6 29033.5 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#2] jquery.html Cycles:180 Average:28729.60 Median:2419.12 stddev:81119.99 (3353.3%) stddev-sans-first:81319.62 10:22:54 INFO - PROCESS | 4989 | Values: 377.8 379.9 386.6 393.6 399.7 15434.9 17407.9 18801.6 20348.2 20381.9 18788.5 19216.4 19982.1 20053.6 20127.6 5279.3 5492.8 5594.1 5597.9 5639.6 5422.1 5517.0 5736.7 5739.1 5742.6 5689.4 5716.2 5738.3 6289.2 6337.5 5753.6 5974.9 6316.2 6316.6 6325.2 5498.1 5509.9 5519.8 5530.1 5545.4 13801.9 18253.1 21456.5 22957.3 23037.0 2266.3 2270.6 2347.8 2490.5 2680.2 9613.9 9765.9 9820.1 10094.5 10344.5 1927.3 1993.2 2001.3 2035.9 2043.4 55220.7 82586.6 83267.6 83685.0 84330.2 10318.0 10375.7 10560.4 10703.2 10730.9 12165.5 13172.1 14061.2 14539.9 14555.1 7506.5 7571.7 7697.2 7789.6 7838.0 7408.6 7425.4 7461.3 7566.6 7572.4 4407.9 4408.6 4409.5 4426.0 4568.1 1855.6 1897.5 1922.1 1934.4 1945.6 921.6 1006.3 1025.2 1088.1 1122.3 18835.3 19312.5 19316.7 19364.8 19499.1 977.9 996.4 1010.7 1044.9 1096.8 10163.9 10780.0 10807.4 10813.9 10846.1 444732.0 448469.0 514435.0 515700.0 530290.0 82692.6 85188.0 85480.1 97998.0 101367.5 970.9 1018.1 1020.8 1021.9 1039.8 17914.2 18057.6 18100.7 18181.7 18318.1 40104.6 41378.6 41450.2 41798.2 42983.6 57548.7 58738.7 58976.4 59277.0 59573.7 8419.7 8515.7 8557.0 8673.2 8673.8 9548.9 12646.6 13018.4 13430.2 13830.0 11679.4 11687.9 11740.3 11947.6 12001.1 11316.3 11499.1 11826.8 11858.8 12111.3 11404.1 11678.2 11891.6 11986.6 12003.6 7004.9 7417.1 8477.0 8530.8 8573.5 11449.3 11977.2 12163.3 12182.1 12362.6 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#3] mootools.html Cycles:180 Average:5838.89 Median:443.96 stddev:3372.50 (759.6%) stddev-sans-first:3365.27 10:22:54 INFO - PROCESS | 4989 | Values: 1374.2 1393.0 1531.8 1734.7 1749.4 7213.7 8493.1 8521.4 9160.8 9173.1 8357.2 8555.3 8557.8 8618.1 8710.3 2260.2 2299.9 2305.1 2305.2 2306.5 2211.8 2229.6 2258.5 2260.6 2265.4 2292.3 2302.2 2325.3 2340.9 2346.9 2202.6 2202.6 2211.5 2217.4 2219.9 2161.6 2173.5 2173.7 2174.4 2176.2 8926.9 8938.5 9019.9 9027.1 9041.9 5152.7 5252.2 5252.9 5282.5 5285.0 3038.2 3121.8 3170.4 3259.6 3277.2 1058.8 1073.7 1081.4 1103.9 1114.3 12513.6 12598.7 12632.3 12649.3 12651.2 4519.3 4616.7 4655.6 4710.4 4734.7 10415.3 10432.5 10446.5 10453.7 10474.3 5223.1 5245.0 5254.0 5256.8 5262.9 4082.0 4752.8 4766.2 4824.0 4922.1 3923.5 3965.4 3992.9 4052.0 4163.2 1242.9 1252.3 1261.7 1285.4 1290.3 984.0 1021.0 1023.4 1030.7 1040.3 6181.4 6228.4 6256.5 6370.8 6462.4 433.4 440.1 440.4 443.0 444.9 4384.6 4416.6 4459.2 4478.5 4490.8 10800.9 11042.8 11194.3 11221.4 11237.0 10514.3 10860.2 10942.8 11240.8 11264.5 7896.9 8188.5 8199.3 8201.7 8209.4 6063.9 6349.6 6397.1 6470.5 6497.0 10055.6 10182.0 10191.1 10251.8 10385.5 10290.4 10395.8 10435.5 10445.7 10488.9 6816.5 7698.1 8025.6 8033.1 8211.9 8668.3 8703.4 8754.0 8763.3 8795.2 7442.5 7443.0 7601.3 7750.1 8070.9 7372.2 7495.1 7616.2 7654.2 7697.0 6962.7 7035.7 7048.1 7050.4 7054.2 5216.2 5296.8 5304.9 5315.9 5507.8 5211.5 5441.9 5490.8 5551.6 5584.4 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#4] prototype.html Cycles:180 Average:4762.41 Median:5407.18 stddev:1398.56 (25.9%) stddev-sans-first:1361.98 10:22:54 INFO - PROCESS | 4989 | Values: 310.8 316.7 318.2 329.0 332.8 5474.6 5517.6 5652.8 5689.6 5719.9 5550.4 5594.8 5596.9 5630.9 5642.3 4337.2 4340.1 4360.8 4366.6 4406.0 4061.6 4314.1 4324.3 4369.0 4392.3 4275.6 4276.3 4276.6 4278.3 4292.7 4305.0 4310.4 4320.8 4322.5 4327.7 3525.9 3761.6 3764.1 3767.1 3770.0 5449.5 5463.6 5516.9 5531.7 5533.0 4882.5 4894.6 4923.3 4926.8 4948.0 5582.8 5840.8 5860.4 5868.6 5935.4 4109.4 4130.8 4144.7 4151.1 4174.2 6148.1 6154.5 6161.0 6218.4 6236.3 4096.1 4191.0 4195.8 4216.4 4237.7 4230.4 4235.5 4240.4 4258.6 4267.3 4873.8 4911.3 4981.9 4989.2 4990.7 5829.4 5925.3 5978.9 6022.2 6032.3 1420.8 1442.7 1446.5 1469.9 1471.1 889.2 922.0 935.6 937.6 945.0 5038.2 5045.9 5060.0 5110.2 5112.4 5380.5 5431.4 5433.4 5440.0 5455.9 4878.8 5058.8 5072.4 5105.3 5115.2 2870.4 2886.8 2913.4 2914.3 2920.4 5483.6 5501.0 5541.5 5543.5 5550.6 5151.6 5455.7 5471.0 5485.9 5495.9 5465.7 5511.9 5516.3 5524.8 5538.6 5232.4 5267.2 5326.0 5387.5 5402.5 5368.4 5372.5 5386.8 5394.5 5411.9 5412.4 5471.8 5482.4 5588.7 5971.7 4081.2 4189.0 4199.4 4207.1 4209.6 5990.1 6067.7 6071.3 6151.3 6165.8 5646.9 5834.7 5922.5 5961.1 5970.8 5838.2 5873.9 5905.9 5936.9 5967.3 5753.7 5775.5 5781.4 5792.1 5798.4 5645.9 5838.5 5838.9 5885.1 5911.0 5805.2 5821.3 5840.8 5842.1 5859.9 10:22:54 INFO - PROCESS | 4989 | 10:22:54 INFO - PROCESS | 4989 | [#5] yui.html Cycles:180 Average:20406.72 Median:4067.91 stddev:29258.24 (719.2%) stddev-sans-first:29302.73 10:22:54 INFO - PROCESS | 4989 | Values: 655.1 655.6 729.7 753.8 786.0 14058.6 14471.3 14515.6 14518.9 14629.6 16110.0 16139.9 16308.9 16408.0 16442.9 789.7 813.2 818.9 826.7 827.3 828.1 833.0 835.3 835.6 838.8 846.0 847.2 850.4 850.9 856.9 845.3 845.6 845.9 846.4 849.8 614.4 615.2 617.9 618.5 618.7 15105.5 15142.2 15146.9 15188.2 15199.5 14652.7 14832.8 14843.9 14852.8 14912.2 12447.1 12559.6 12705.4 12809.2 13000.0 3799.6 3914.8 3974.9 4050.5 4085.3 74461.0 76648.0 77336.0 77630.2 78840.0 11253.0 11323.2 11568.1 11570.5 11971.3 21285.3 21342.0 21408.9 21411.8 21422.1 8375.7 8405.0 8515.1 8515.1 8818.6 4582.7 4673.8 4768.6 4778.0 4846.2 3427.5 3541.4 3551.6 3555.8 3566.5 592.9 619.9 623.4 626.1 636.9 630.3 735.7 742.5 752.6 767.9 9703.8 9906.7 10124.1 10129.6 10208.8 617.7 636.3 667.5 692.2 729.0 4708.9 4924.7 4967.4 4974.6 4982.5 98395.0 102678.4 102757.0 108407.5 109031.5 101990.0 102645.5 103331.0 103332.5 103889.5 67602.7 86891.6 87366.0 88099.0 89621.6 9593.4 9721.7 9798.6 9820.8 9849.3 51235.0 52039.5 52317.7 53994.7 54220.0 66054.7 67701.7 74383.0 77530.0 77891.0 11122.7 11270.3 11317.9 11329.8 11999.2 12973.2 13002.7 13013.5 13063.5 13192.0 12461.4 12754.4 12922.4 12986.6 13563.3 11635.0 11702.1 12137.6 12496.6 12801.2 11103.7 11386.8 11543.4 11656.9 11744.8 10346.4 10499.8 10556.7 10634.6 10818.0 10505.0 10960.7 10978.6 11070.7 11150.8 10:22:54 INFO - PROCESS | 4989 | -------- Summary: end -------- 10:22:54 INFO - PROCESS | 4989 | 10:22:55 INFO - TEST-INFO | 4989: exit 0 10:22:55 INFO - TEST-OK | dromaeo_css | took 1111551ms 10:22:55 INFO - TEST-START | kraken 10:22:55 INFO - operating with platform_type : linux_ 10:22:55 INFO - Initialising browser for kraken test... 10:22:55 INFO - TEST-INFO | started process 5223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstaZ3k/profile http://localhost:60645/getInfo.html) 10:23:00 INFO - PROCESS | 5223 | __metrics Screen width/height:1600/1200 10:23:00 INFO - PROCESS | 5223 | colorDepth:24 10:23:00 INFO - PROCESS | 5223 | Browser inner width/height: 1024/697 10:23:00 INFO - PROCESS | 5223 | __metrics 10:23:01 ERROR - PROCESS | 5223 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:23:02 INFO - TEST-INFO | 5223: exit 0 10:23:02 INFO - Browser initialized. 10:23:02 INFO - Running cycle 1/1 for kraken test... 10:23:02 INFO - TEST-INFO | started process 5341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstaZ3k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:14 INFO - PROCESS | 5341 | RSS: Main: 185466880 10:23:14 INFO - PROCESS | 5341 | 10:23:16 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60645/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:17 INFO - PROCESS | 5341 | RSS: Main: 191070208 10:23:17 INFO - PROCESS | 5341 | 10:23:20 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60645/tests/kraken/driver.html?testName=audio-dft) 10:23:20 INFO - PROCESS | 5341 | RSS: Main: 189952000 10:23:20 INFO - PROCESS | 5341 | 10:23:23 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60645/tests/kraken/driver.html?testName=audio-fft) 10:23:24 INFO - PROCESS | 5341 | RSS: Main: 185798656 10:23:24 INFO - PROCESS | 5341 | 10:23:26 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60645/tests/kraken/driver.html?testName=audio-oscillator) 10:23:27 INFO - PROCESS | 5341 | RSS: Main: 185851904 10:23:27 INFO - PROCESS | 5341 | 10:23:29 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60645/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:29 INFO - PROCESS | 5341 | RSS: Main: 186413056 10:23:29 INFO - PROCESS | 5341 | 10:23:32 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60645/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:33 INFO - PROCESS | 5341 | RSS: Main: 187113472 10:23:33 INFO - PROCESS | 5341 | 10:23:37 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60645/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:37 INFO - PROCESS | 5341 | RSS: Main: 184451072 10:23:37 INFO - PROCESS | 5341 | 10:23:40 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60645/tests/kraken/driver.html?testName=json-parse-financial) 10:23:41 INFO - PROCESS | 5341 | RSS: Main: 185659392 10:23:41 INFO - PROCESS | 5341 | 10:23:42 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60645/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:43 INFO - PROCESS | 5341 | RSS: Main: 186191872 10:23:43 INFO - PROCESS | 5341 | 10:23:45 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:45 INFO - PROCESS | 5341 | RSS: Main: 186134528 10:23:45 INFO - PROCESS | 5341 | 10:23:47 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:48 INFO - PROCESS | 5341 | RSS: Main: 186564608 10:23:48 INFO - PROCESS | 5341 | 10:23:51 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:51 INFO - PROCESS | 5341 | RSS: Main: 186769408 10:23:51 INFO - PROCESS | 5341 | 10:23:54 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:55 INFO - PROCESS | 5341 | RSS: Main: 186064896 10:23:55 INFO - PROCESS | 5341 | 10:23:56 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:60645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60645/tests/kraken/driver.html?testName=ai-astar) 10:23:57 INFO - PROCESS | 5341 | RSS: Main: 187588608 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | __start_tp_report 10:23:57 INFO - PROCESS | 5341 | _x_x_mozilla_page_load 10:23:57 INFO - PROCESS | 5341 | _x_x_mozilla_page_load_details 10:23:57 INFO - PROCESS | 5341 | |i|pagename|runs| 10:23:57 INFO - PROCESS | 5341 | |0;ai-astar;113;107;113;114;113;114;112;111;112;112 10:23:57 INFO - PROCESS | 5341 | |1;audio-beat-detection;162;131;155;181;126;161;163;138;186;129 10:23:57 INFO - PROCESS | 5341 | |2;audio-dft;163;165;164;165;167;168;163;163;163;163 10:23:57 INFO - PROCESS | 5341 | |3;audio-fft;75;75;75;171;76;76;76;79;162;76 10:23:57 INFO - PROCESS | 5341 | |4;audio-oscillator;84;84;147;84;84;87;129;85;84;143 10:23:57 INFO - PROCESS | 5341 | |5;imaging-gaussian-blur;117;117;118;117;118;119;117;118;118;117 10:23:57 INFO - PROCESS | 5341 | |6;imaging-darkroom;148;147;147;149;148;147;147;147;147;147 10:23:57 INFO - PROCESS | 5341 | |7;imaging-desaturate;97;97;96;95;96;95;97;96;96;95 10:23:57 INFO - PROCESS | 5341 | |8;json-parse-financial;55;53;54;55;57;54;56;53;53;55 10:23:57 INFO - PROCESS | 5341 | |9;json-stringify-tinderbox;64;64;64;63;63;63;63;64;63;66 10:23:57 INFO - PROCESS | 5341 | |10;stanford-crypto-aes;81;80;79;86;83;80;86;83;108;85 10:23:57 INFO - PROCESS | 5341 | |11;stanford-crypto-ccm;123;124;133;124;135;124;128;127;131;131 10:23:57 INFO - PROCESS | 5341 | |12;stanford-crypto-pbkdf2;170;166;167;164;163;164;163;167;165;162 10:23:57 INFO - PROCESS | 5341 | |13;stanford-crypto-sha256-iterative;66;68;66;65;64;66;67;63;67;63 10:23:57 INFO - PROCESS | 5341 | __end_tp_report 10:23:57 INFO - PROCESS | 5341 | __start_cc_report 10:23:57 INFO - PROCESS | 5341 | _x_x_mozilla_cycle_collect,883 10:23:57 INFO - PROCESS | 5341 | __end_cc_report 10:23:57 INFO - PROCESS | 5341 | __startTimestamp1465925037190__endTimestamp 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | ------- Summary: start ------- 10:23:57 INFO - PROCESS | 5341 | Number of tests: 14 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.02 (1.8%) stddev-sans-first:2.12 10:23:57 INFO - PROCESS | 5341 | Values: 113.0 107.0 113.0 114.0 113.0 114.0 112.0 111.0 112.0 112.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:161.50 stddev:21.44 (13.3%) stddev-sans-first:22.50 10:23:57 INFO - PROCESS | 5341 | Values: 162.0 131.0 155.0 181.0 126.0 161.0 163.0 138.0 186.0 129.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.88 10:23:57 INFO - PROCESS | 5341 | Values: 163.0 165.0 164.0 165.0 167.0 168.0 163.0 163.0 163.0 163.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.23 (50.3%) stddev-sans-first:39.92 10:23:57 INFO - PROCESS | 5341 | Values: 75.0 75.0 75.0 171.0 76.0 76.0 76.0 79.0 162.0 76.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:84.00 stddev:27.00 (32.1%) stddev-sans-first:27.92 10:23:57 INFO - PROCESS | 5341 | Values: 84.0 84.0 147.0 84.0 84.0 87.0 129.0 85.0 84.0 143.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:23:57 INFO - PROCESS | 5341 | Values: 117.0 117.0 118.0 117.0 118.0 119.0 117.0 118.0 118.0 117.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:23:57 INFO - PROCESS | 5341 | Values: 148.0 147.0 147.0 149.0 148.0 147.0 147.0 147.0 147.0 147.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 10:23:57 INFO - PROCESS | 5341 | Values: 97.0 97.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 95.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 10:23:57 INFO - PROCESS | 5341 | Values: 55.0 53.0 54.0 55.0 57.0 54.0 56.0 53.0 53.0 55.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 10:23:57 INFO - PROCESS | 5341 | Values: 64.0 64.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 66.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:83.00 stddev:8.44 (10.2%) stddev-sans-first:8.82 10:23:57 INFO - PROCESS | 5341 | Values: 81.0 80.0 79.0 86.0 83.0 80.0 86.0 83.0 108.0 85.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.50 stddev:4.29 (3.3%) stddev-sans-first:4.16 10:23:57 INFO - PROCESS | 5341 | Values: 123.0 124.0 133.0 124.0 135.0 124.0 128.0 127.0 131.0 131.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.50 stddev:2.42 (1.5%) stddev-sans-first:1.81 10:23:57 INFO - PROCESS | 5341 | Values: 170.0 166.0 167.0 164.0 163.0 164.0 163.0 167.0 165.0 162.0 10:23:57 INFO - PROCESS | 5341 | 10:23:57 INFO - PROCESS | 5341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.81 10:23:57 INFO - PROCESS | 5341 | Values: 66.0 68.0 66.0 65.0 64.0 66.0 67.0 63.0 67.0 63.0 10:23:57 INFO - PROCESS | 5341 | -------- Summary: end -------- 10:23:57 INFO - PROCESS | 5341 | 10:23:58 INFO - TEST-INFO | 5341: exit 0 10:23:58 INFO - TEST-OK | kraken | took 62480ms 10:23:58 INFO - SUITE-END | took 1174s 10:23:58 INFO - Completed test suite (00:19:34) 10:23:58 INFO - javascript benchmark 10:23:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7133.013625993775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.508878579427, 3090.119315994942, 3141.5758872552196, 3144.4025635129315, 3168.8890888818896, 5400.000999815032, 5407.540359069474, 5439.102548079567, 5504.036793561131, 5522.91715624266, 5239.266502689627, 5375.919361209585, 5408.729563521828, 5430.83707488776, 5462.071447853865, 4888.07126645937, 4910.06708725341, 5015.824446144386, 5047.621428392885, 5100.923486147711, 4898.804047838083, 5122.282880396748, 5155.587552995751, 5156.046131465672, 5169.534741873231, 4799.232122860343, 4857.222844344923, 4870.0, 4977.776000079987, 4983.028309479635, 4897.33885925399, 4900.926486102711, 4902.950970490285, 4915.729634870081, 4936.605071594264, 4866.8806174579695, 4871.732054736988, 4876.414830220361, 4886.9511304886855, 4908.435529914034, 5210.791568337262, 5307.389650190239, 5374.032674118657, 5434.266374039494, 5454.972725136349, 5771.826845194651, 5772.393898640625, 5804.158397032406, 5811.244538210048, 5817.447342502455, 5562.082256427685, 5804.65172089676, 5809.157672137517, 5821.79623713168, 5833.7083145842535, 5443.945560544384, 5451.48210919962, 5496.532794712454, 5530.972345138329, 5548.667079975174, 6024.909626355608, 6028.939710602838, 6033.9698301508215, 6036.215292012011, 6040.969795150996, 5455.8363249102595, 5655.3779084300695, 5754.510866576305, 5773.076307790818, 5809.854753631109, 5795.797147099831, 5817.825465236049, 5828.6502809831545, 5847.298324201123, 5909.911351329733, 5489.560835133179, 5688.089905615082, 5805.245318108618, 5806.593538452268, 5822.097574875901, 5510.035743744828, 5711.200431939532, 5771.653700777967, 5794.88410231793, 5862.384449632812, 4367.672424568106, 4379.233634114081, 4392.033752574429, 4401.339799030171, 4420.845270415584, 3920.6079392060565, 3928.5678575356687, 3938.8818335449982, 3969.8412063517712, 3973.0663294125857, 5500.22996780451, 5504.284443022381, 5507.981023510663, 5530.6128571000445, 5583.860403489864, 5873.3832947539895, 5881.235439392852, 5897.64614123154, 5915.231019967377, 5940.227770389822, 5630.943690563124, 5640.069388550925, 5649.915251271234, 5653.0, 5653.858653533613, 4884.389451318585, 5033.5721463676, 5042.520960508746, 5057.089723849743, 5112.0, 6027.969860150672, 6044.7582096716515, 6045.758169673164, 6052.606580572248, 6073.362296958844, 5889.146073819272, 5894.440028197314, 5897.203877476486, 5903.645781253139, 5912.881742365214, 5774.94225057744, 5926.1999630049395, 5931.970340148272, 5982.102684597346, 6017.849553761191, 5713.857153571194, 5722.456366645162, 5727.942720572908, 5729.1119876419225, 5739.5695322850115, 5609.074502707008, 5806.622569532967, 5826.679532625746, 5828.59199856006, 5837.6497410155525, 5561.221429000024, 5574.191742197439, 5617.775288988395, 5635.351934527418, 5640.915386269127, 5557.916631250615, 5559.19391688211, 5566.387697353207, 5611.607187496836, 5649.661020338793, 5487.396386397573, 5575.860603484945, 5576.163575463713, 5588.552915766811, 5595.8880822384135, 5449.427810079885, 5548.833534993957, 5564.860878478071, 5628.437156284503, 5634.535020894515, 5513.090340094, 5514.779408823602, 5532.0, 5556.666600004012, 5592.356878958972], "value": 5347.6917094175615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.0486863715099, 606.5026678123941, 627.1502114634669, 649.7303618998114, 658.8616390557983, 39561.80219098904, 43080.78459607698, 43425.0, 43464.78267608657, 43481.34777978329, 42542.0, 43240.0, 43285.7835710821, 43431.13137737243, 43473.0, 8807.207351338378, 8864.512451815148, 8877.866831997526, 8945.64217431302, 8953.910460895406, 8731.694390696326, 8904.065073167321, 8907.421017633866, 8921.643134274622, 8972.192502674758, 8911.598978045971, 8953.865692014626, 8987.0, 9012.41419307743, 9035.864462033074, 8892.866607000868, 8915.331350148765, 8919.197272245465, 8933.419327743675, 8940.73177804667, 8739.951205855274, 8842.911570884273, 8846.911530884674, 8864.955675221583, 8920.330975176823, 40909.79545102285, 41041.58958410408, 41658.0, 41732.79133604343, 41746.373804392955, 2928.2532954096782, 3391.2369716813764, 3413.8805141820167, 3418.9487157692656, 3452.4130897747445, 30978.84510577455, 31756.841215793775, 31759.364812703847, 31793.205169870707, 31998.20004499883, 4113.691473139526, 4220.85227017053, 4237.470316210473, 4270.167317373113, 4398.142362239365, 294957.0, 295601.0, 297934.0, 298227.0, 300309.0, 34133.48799768005, 34535.0, 34545.65454345424, 34607.4808877867, 35551.82224088863, 36562.63437365645, 36671.633283667354, 36715.449268261, 36732.44901326482, 36776.448353274725, 12984.610461686165, 13013.869861301455, 13021.414036368385, 13026.609201723963, 13103.60689179326, 12269.570565030359, 12298.20061695987, 12350.197237179555, 12443.813342799865, 12494.500219991098, 8217.383696222807, 8307.709230176915, 8337.166283371615, 8412.747617571482, 8439.535825529654, 3189.091109033914, 3190.6330771961057, 3220.5813244278092, 3295.385261221984, 3296.0, 898.384606544506, 1024.9180065594735, 1048.8112139814907, 1052.8052310322614, 1152.504423098059, 32731.836340818143, 33096.0, 33319.333613327595, 33360.0, 33475.49786753201, 1019.5259204469809, 1079.5897558927556, 1080.6325849211305, 1089.455272363818, 1094.2777766673958, 15939.282732277075, 16147.515574532548, 16288.918555407146, 16817.663646726996, 16846.41037563704, 608338.0, 610340.4829758494, 611157.0, 613939.0, 615934.0, 56852.43147568554, 58379.0, 58483.0, 58484.0, 58616.0, 1310.8033794930645, 1325.1254172246463, 1335.0921373466135, 1344.798280257969, 1352.114365090867, 29917.252068698457, 30999.0, 31335.84332078325, 31796.205094871886, 32144.67855321417, 49149.262761059326, 49920.0, 50023.0, 50323.74838125786, 50381.49618503915, 441788.3284668577, 443087.0, 443691.0, 444689.0, 445007.0, 27732.44535109246, 28059.298517537223, 28110.2972425691, 28275.858620707586, 28730.856345718137, 48410.5158948406, 48694.75652621714, 48721.0, 48872.51127488822, 48973.0, 41766.5583604099, 42004.3699344504, 42257.366139507314, 42419.57580424156, 42875.0, 40990.590094098676, 41039.794801027, 41078.58921410747, 41475.1704965905, 41635.37546936859, 36612.81693591621, 40760.184796303314, 41235.175296494504, 41564.0, 41600.791996041036, 32382.19044523906, 37345.626543734215, 37669.7980671646, 37956.620433796415, 38136.0, 28296.08673267914, 28706.0, 28868.711312886604, 28895.56656650194, 29033.499807529868], "value": 18481.459351858804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.79032636886535, 379.8822365066828, 386.56125297787014, 393.64768532163714, 399.67825900150365, 15434.922825385886, 17407.912960435195, 18801.623967520674, 20348.1860725571, 20381.898090509545, 18788.53028674284, 19216.42350729477, 19982.100805463753, 20053.59892802143, 20127.59744805103, 5279.313689220415, 5492.752826122834, 5594.0769772987405, 5597.852440249739, 5639.6334238274585, 5422.132458806592, 5517.0, 5736.6558006519535, 5739.081746920494, 5742.569307301948, 5689.358442514484, 5716.1997320375185, 5738.282714660668, 6289.182406287199, 6337.493000559944, 5753.597248192628, 5974.880502389971, 6316.178896743417, 6316.621002739827, 6325.1777268954975, 5498.147787093007, 5509.917351239735, 5519.806806761744, 5530.115181570929, 5545.390007099216, 13801.861981380158, 18253.087345632797, 21456.463588410257, 22957.311280661608, 23037.0, 2266.331432227497, 2270.5685919675375, 2347.788699017097, 2490.452100537879, 2680.209338245222, 9613.855792163124, 9765.90234097657, 9820.067093626094, 10094.49527523621, 10344.5344959477, 1927.3254360973688, 1993.1728332742039, 2001.329554599211, 2035.877847329165, 2043.438054535, 55220.72389638026, 82586.58706706428, 83267.5836620813, 83685.0, 84330.15669843284, 10318.0, 10375.740606484747, 10560.419176945188, 10703.19726020536, 10730.94634526838, 12165.513379464723, 13172.07795454309, 14061.226632535308, 14539.85460145385, 14555.05392149507, 7506.512076714996, 7571.697132114654, 7697.153313135551, 7789.64946577394, 7837.960810196027, 7408.592527411044, 7425.368843648243, 7461.291177338144, 7566.621668916532, 7572.356349710336, 4407.889802754893, 4408.58118478744, 4409.492908315585, 4425.955740442554, 4568.109218702388, 1855.6103218324033, 1897.459224121119, 1922.09661459114, 1934.35199208264, 1945.6206039822098, 921.6267411698273, 1006.2553710254359, 1025.2003437318904, 1088.0914436445657, 1122.3434290939729, 18835.340763073225, 19312.517187070436, 19316.71024934627, 19364.806351936582, 19499.122539485757, 977.9364341317792, 996.4121168510469, 1010.722051435861, 1044.921630877672, 1096.780643871213, 10163.94918025405, 10780.0, 10807.351558906334, 10813.891861081445, 10846.132309415229, 444732.0, 448469.0, 514435.0, 515700.0, 530290.0, 82692.58653706693, 85188.0, 85480.14519854846, 97998.0, 101367.49316253519, 970.9174720148725, 1018.0786388318436, 1020.831562792131, 1021.9131373833308, 1039.7868436970402, 17914.193861276013, 18057.63884722272, 18100.72848907294, 18181.727274090634, 18318.08409579489, 40104.598954010085, 41378.586214138675, 41450.170996580506, 41798.1640367197, 42983.570164299206, 57548.71225643845, 58738.70630646819, 58976.41023589881, 59277.0, 59573.7021314908, 8419.70531031411, 8515.74452766418, 8556.957215213884, 8673.176048275403, 8673.783155421164, 9548.85676714836, 12646.557370491988, 13018.414171362121, 13430.19418834873, 13830.0, 11679.357635330138, 11687.88312116902, 11740.295582265091, 11947.641570752892, 12001.099917506048, 11316.321020738782, 11499.13756468285, 11826.82259766087, 11858.822117668415, 12111.333876636518, 11404.144689148181, 11678.182527223013, 11891.583794567148, 11986.64040078799, 12003.579874704343, 7004.859902802017, 7417.147028091838, 8477.0, 8530.829383412422, 8573.485590864568, 11449.313041217554, 11977.221480603734, 12163.2702037878, 12182.147249692436, 12362.629121126382], "value": 9102.663371237608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.2166964830046, 1393.0457636518986, 1531.8085239345082, 1734.6964281250778, 1749.396458221913, 7213.711451541932, 8493.108223636515, 8521.44610600312, 9160.816783664332, 9173.128552787482, 8357.20606542379, 8555.315574754004, 8557.828843423144, 8618.052014278424, 8710.346723995694, 2260.2315212827634, 2299.8850057497143, 2305.0549274797336, 2305.227748704186, 2306.5041016181517, 2211.7788221177916, 2229.57638048771, 2258.4692597239637, 2260.581792368409, 2265.3770213191337, 2292.2893902890073, 2302.2172461363134, 2325.3140323604575, 2340.9297721068397, 2346.894389752457, 2202.570498752744, 2202.647576387786, 2211.5466329402434, 2217.401301648562, 2219.933401997943, 2161.6217161996747, 2173.4566358410398, 2173.7065496158134, 2174.412908514708, 2176.183931025865, 8926.910730892672, 8938.46369217849, 9019.909800901973, 9027.05215952322, 9041.909580904172, 5152.690838549662, 5252.23842542833, 5252.947470525322, 5282.524572788468, 5284.973575132138, 3038.2404398900276, 3121.812691238533, 3170.4451720948973, 3259.5925509311337, 3277.246233366315, 1058.8147074262051, 1073.7154654016692, 1081.3998230981801, 1103.9227254092136, 1114.2645853736494, 12513.624591262276, 12598.74802503954, 12632.30522321272, 12649.304288264142, 12651.177673451197, 4519.344695019204, 4616.699914505546, 4655.580997710223, 4710.387649605598, 4734.668573199911, 10415.323004004867, 10432.530536125892, 10446.477676116316, 10453.68638940833, 10474.319169253975, 5223.112070947948, 5244.9737751310995, 5254.0, 5256.789728410898, 5262.894742105136, 4081.959180408158, 4752.7861246244, 4766.189747742892, 4823.9517604824205, 4922.114019476457, 3923.489946306962, 3965.4448377227213, 3992.940105898414, 4052.0, 4163.208990291835, 1242.931638759877, 1252.3362617812575, 1261.7161138743893, 1285.3830161522521, 1290.2709968867748, 983.9950800246096, 1020.9897901021043, 1023.3501726403787, 1030.7320096774743, 1040.266612038511, 6181.426963673925, 6228.439440450381, 6256.468200203034, 6370.8088757337355, 6462.3537646235, 433.3910855248318, 440.0626665203097, 440.4384409877432, 443.01650336253465, 444.90212153326866, 4384.583464570861, 4416.646668266531, 4459.241928872035, 4478.462584489882, 4490.820367185276, 10800.945995269973, 11042.779144417227, 11194.272372295774, 11221.438928053565, 11237.04485118774, 10514.316569422963, 10860.239783215256, 10942.835857462145, 11240.775184496428, 11264.493097810619, 7896.921030789734, 8188.50868947865, 8199.344052475788, 8201.71294004707, 8209.384296177692, 6063.909041364295, 6349.619022858643, 6397.072424498515, 6470.514711396759, 6496.960486322166, 10055.597776088875, 10181.981801819758, 10191.082802547806, 10251.84622230682, 10385.532651030873, 10290.434026128336, 10395.792084158124, 10435.530401131815, 10445.738856528647, 10488.895111048792, 6816.454683625398, 7698.114716807639, 8025.558594277138, 8033.116357200586, 8211.917880821115, 8668.263197628272, 8703.390762646553, 8754.0, 8763.298936085226, 8795.208431241219, 7442.479026468095, 7443.0, 7601.315881570686, 7750.0699916010435, 8070.87893681607, 7372.152202496782, 7495.1005879294835, 7616.162222155669, 7654.2345765423015, 7696.961515192388, 6962.686679099352, 7035.718571257297, 7048.118985126859, 7050.365467107985, 7054.153501579844, 5216.243644671577, 5296.814611488579, 5304.867378315419, 5315.867103322448, 5507.807226747044, 5211.530962213419, 5441.918371224514, 5490.80782172622, 5551.555875530029, 5584.357798853184], "value": 4564.932677400149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.79953430037625, 316.67382595926205, 318.2298836814907, 328.9983550082249, 332.82360349015033, 5474.589405794572, 5517.641353312042, 5652.784651299975, 5689.573282003851, 5719.885602287952, 5550.417206193352, 5594.797118619496, 5596.888062238752, 5630.943690563104, 5642.266505354309, 4337.219300525896, 4340.110277393127, 4360.803763830635, 4366.607005369516, 4405.986623076678, 4061.614146656063, 4314.115606300701, 4324.264874971247, 4369.0, 4392.3191905254735, 4275.593818587229, 4276.315789473685, 4276.636485898703, 4278.315469524877, 4292.699511034229, 4305.0098477350075, 4310.353446982962, 4320.805563749639, 4322.459692538433, 4327.744953963347, 3525.9294814103832, 3761.570603170805, 3764.1342491226897, 3767.1335592813534, 3769.981150094232, 5449.536789372908, 5463.617546771688, 5516.8966206758805, 5531.668099914018, 5532.984523434738, 4882.536159064884, 4894.632902532324, 4923.261510773377, 4926.75366231687, 4948.0, 5582.8325150245555, 5840.766369345263, 5860.355360910296, 5868.589198756089, 5935.406459354073, 4109.4246805447265, 4130.772807495587, 4144.72040377791, 4151.14901445206, 4174.186033723425, 6148.108524264001, 6154.522694677493, 6160.969195154041, 6218.378162183791, 6236.251649802053, 4096.09885825118, 4191.0, 4195.811188496525, 4216.367544868294, 4237.724547904377, 4230.386593943861, 4235.496398778451, 4240.38514415408, 4258.552851950562, 4267.338562522814, 4873.756312184448, 4911.287863259808, 4981.850544483599, 4989.151844186497, 4990.675606085593, 5829.446202610745, 5925.259342582177, 5978.910316345258, 6022.247219097613, 6032.336442991267, 1420.779779134236, 1442.668186317132, 1446.464808021018, 1469.860363265488, 1471.1026273972868, 889.1863944490848, 921.9723408297762, 935.6257497001118, 937.634322614181, 944.9699827188398, 5038.219076043146, 5045.8738531537, 5060.0, 5110.233464980209, 5112.412072611697, 5380.515753582196, 5431.375391829911, 5433.375161856358, 5439.972800135974, 5455.945440545624, 4878.755917241081, 5058.83646761247, 5072.376839411427, 5105.289727941107, 5115.1559992600805, 2870.368518925833, 2886.81640527387, 2913.4027524357457, 2914.2568644995813, 2920.415916816645, 5483.588730845203, 5501.0, 5541.5289700375915, 5543.52880005204, 5550.611457197957, 5151.557563882119, 5455.699936503531, 5471.003083874357, 5485.930243602459, 5495.917561236504, 5465.672059676433, 5511.944880551223, 5516.3380394352935, 5524.779008839601, 5538.6122971391615, 5232.424433312256, 5267.236250743697, 5326.0, 5387.542058925035, 5402.486763757437, 5368.416317186361, 5372.516473517402, 5386.814900721835, 5394.460553944574, 5411.863508663225, 5412.43039518551, 5471.823557935063, 5482.369527504388, 5588.708629461901, 5971.671558064349, 4081.2449696806184, 4188.958110418978, 4199.433076534751, 4207.116505533872, 4209.5790420957655, 5990.071538911476, 6067.696615169312, 6071.301800293023, 6151.292601350902, 6165.84585385351, 5646.88706225865, 5834.7082645866685, 5922.466977972003, 5961.105834124916, 5970.791022314198, 5838.182654428469, 5873.911891321719, 5905.91141132892, 5936.940630593639, 5967.283925928917, 5753.741081651252, 5775.480206781242, 5781.392953739797, 5792.088610758524, 5798.420157984337, 5645.943540564542, 5838.503727183067, 5838.912416313674, 5885.117232415172, 5911.0, 5805.158252053513, 5821.27234095738, 5840.795572154954, 5842.065269556851, 5859.853503662443], "value": 4307.739859791611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.0861548140348, 655.6393983309179, 729.711763853278, 753.8416932444186, 785.9607019649018, 14058.648533786647, 14471.276436178201, 14515.637109072279, 14518.854811451882, 14629.634259143513, 16110.0, 16139.919300403511, 16308.918455407706, 16408.0, 16442.917785411057, 789.6722860013087, 813.2477458351032, 818.8689809630446, 826.669332267095, 827.3133299361516, 828.0725587342155, 832.9791755206107, 835.2691395029349, 835.5529791561515, 838.8406202821444, 846.0, 847.1570787066877, 850.3877208409934, 850.9319254459659, 856.87146927961, 845.3110714767475, 845.6194712379423, 845.940784145107, 846.3525403066659, 849.8130411309502, 614.4285814192799, 615.1510914937403, 617.9134921111048, 618.5268269773627, 618.7246675229525, 15105.54683359501, 15142.16718080505, 15146.924265378713, 15188.164650944194, 15199.544013679497, 14652.70694586113, 14832.777508337384, 14843.851561484464, 14852.777208341884, 14912.17983010934, 12447.074937389707, 12559.56041538551, 12705.428255728515, 12809.167404118702, 13000.0, 3799.563050249229, 3914.7651140931353, 3974.940375894364, 4050.4734384530116, 4085.346344584852, 74461.0, 76647.99999999945, 77336.0, 77630.22369776286, 78840.0, 11253.0, 11323.207375483802, 11568.074554035657, 11570.537178512934, 11971.341576213217, 21285.255016074363, 21342.0, 21408.892955535124, 21411.78588214098, 21422.143114275565, 8375.664973400995, 8405.0, 8515.14848515156, 8515.14848515156, 8818.559072046372, 4582.679212455163, 4673.813047478131, 4768.642351823558, 4777.976110119496, 4846.151923413388, 3427.451607742799, 3541.4333706607335, 3551.5560554930635, 3555.7866528008403, 3566.465030245484, 592.9466348028698, 619.9380061993854, 623.370395900135, 626.0984182776787, 636.8949123394588, 630.3224034163201, 735.7125031195408, 742.5359150530918, 752.6312107067607, 767.8848172774128, 9703.805923881624, 9906.653267135616, 10124.139448146843, 10129.645462408927, 10208.846867296996, 617.6726335042434, 636.2810024672091, 667.4893706314673, 692.2350802363316, 728.9671964761599, 4708.9058218835435, 4924.657500285087, 4967.3542439482635, 4974.552290293891, 4982.501749824988, 98395.0, 102678.43303917462, 102757.0, 108407.45796270968, 109031.45484272527, 101990.0, 102645.48677256715, 103331.0, 103332.48333758433, 103889.48055259675, 67602.66198668975, 86891.56554217188, 87365.99999999873, 88099.0, 89621.55189224012, 9593.42439453635, 9721.70834874955, 9798.559064841957, 9820.754481137743, 9849.310548261554, 51235.0, 52039.479605203465, 52317.73841130922, 53994.730026349614, 54220.0, 66054.66972665106, 67701.66149169223, 74383.0, 77530.0, 77891.0, 11122.666320010088, 11270.267432616854, 11317.943410283226, 11329.773404532029, 11999.220050696676, 12973.156744811557, 13002.73778593432, 13013.544525941546, 13063.542776002794, 13192.0, 12461.376931153225, 12754.42605082755, 12922.418491167731, 12986.610401687965, 13563.254021028544, 11635.0, 11702.122340824302, 12137.579872204402, 12496.562620308245, 12801.231926084465, 11103.666889993314, 11386.829197562209, 11543.365114918424, 11656.941715291368, 11744.76510469803, 10346.376074005366, 10499.790004200026, 10556.683299501028, 10634.627788027381, 10818.0, 10505.0, 10960.739514955882, 10978.615748448767, 11070.723231919266, 11150.776984460428], "value": 7444.610483324205, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 114.0, 113.0, 114.0, 112.0, 111.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 155.0, 181.0, 126.0, 161.0, 163.0, 138.0, 186.0, 129.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 165.0, 167.0, 168.0, 163.0, 163.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 171.0, 76.0, 76.0, 76.0, 79.0, 162.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 147.0, 84.0, 84.0, 87.0, 129.0, 85.0, 84.0, 143.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 55.0, 57.0, 54.0, 56.0, 53.0, 53.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 66.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 86.0, 83.0, 80.0, 86.0, 83.0, 108.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 133.0, 124.0, 135.0, 124.0, 128.0, 127.0, 131.0, 131.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 167.0, 164.0, 163.0, 164.0, 163.0, 167.0, 165.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 64.0, 66.0, 67.0, 63.0, 67.0, 63.0], "value": 65.5, "unit": "score"}]}]} 10:23:58 INFO - Return code: 0 10:23:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:58 ERROR - # TBPL SUCCESS # 10:23:58 INFO - Running post-action listener: _resource_record_post_action 10:23:58 INFO - ##### 10:23:58 INFO - ##### Finished run-tests step (success) 10:23:58 INFO - ##### 10:23:58 INFO - Running post-run listener: _resource_record_post_run 10:23:58 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 0; Write bytes: 555773952; Read time: 0; Write time: 481428 10:23:58 INFO - TinderboxPrint: CPU usage
13.6% 10:23:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:23:58 INFO - TinderboxPrint: I/O write bytes / time
555,773,952 / 481,428 10:23:58 INFO - TinderboxPrint: CPU idle
8,216.2 (86.4%) 10:23:58 INFO - TinderboxPrint: CPU user
1,231.7 (13.0%) 10:23:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:23:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 192794624; Read time: 0; Write time: 250996 10:23:58 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 0; Write bytes: 292466688; Read time: 0; Write time: 205432 10:23:59 INFO - Running post-run listener: _upload_blobber_files 10:23:59 INFO - Blob upload gear active. 10:23:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:00 INFO - (blobuploader) - INFO - Done attempting. 10:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:01 INFO - (blobuploader) - INFO - Done attempting. 10:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:05 INFO - (blobuploader) - INFO - Done attempting. 10:24:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:05 INFO - Return code: 0 10:24:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adb53743b87bee3dd0a2e449fc27a253729810fa8af27f0f808bf213e9cb4fce5bb6636748ca319e01b12aea65eb61031bb83c6866d519bcdcce9839c09c0228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/456efd264a3a2417f0198095d608195561798c699c3afec4ad4c2039dd9524e857fcdb680ab52facc2a03ba24b294fc92c70a4ea417ad5cc1778e6687ce421c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cafd18b48924ec35bf8825381ba121b7591da1111737db53420c31c3b3f6f67b6b830746d1cffc25ca03fd87e3a27803ffef441af0342452641e8656c2f8cd41"} 10:24:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:05 INFO - Contents: 10:24:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adb53743b87bee3dd0a2e449fc27a253729810fa8af27f0f808bf213e9cb4fce5bb6636748ca319e01b12aea65eb61031bb83c6866d519bcdcce9839c09c0228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/456efd264a3a2417f0198095d608195561798c699c3afec4ad4c2039dd9524e857fcdb680ab52facc2a03ba24b294fc92c70a4ea417ad5cc1778e6687ce421c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cafd18b48924ec35bf8825381ba121b7591da1111737db53420c31c3b3f6f67b6b830746d1cffc25ca03fd87e3a27803ffef441af0342452641e8656c2f8cd41"} 10:24:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:05 INFO - Copying logs to upload dir... 10:24:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.199488 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-14 10:24:04.738514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 10:24:04.742021) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adb53743b87bee3dd0a2e449fc27a253729810fa8af27f0f808bf213e9cb4fce5bb6636748ca319e01b12aea65eb61031bb83c6866d519bcdcce9839c09c0228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/456efd264a3a2417f0198095d608195561798c699c3afec4ad4c2039dd9524e857fcdb680ab52facc2a03ba24b294fc92c70a4ea417ad5cc1778e6687ce421c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cafd18b48924ec35bf8825381ba121b7591da1111737db53420c31c3b3f6f67b6b830746d1cffc25ca03fd87e3a27803ffef441af0342452641e8656c2f8cd41"} build_url:https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/eeEnKAlBSBeTNDTi20fADQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adb53743b87bee3dd0a2e449fc27a253729810fa8af27f0f808bf213e9cb4fce5bb6636748ca319e01b12aea65eb61031bb83c6866d519bcdcce9839c09c0228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/456efd264a3a2417f0198095d608195561798c699c3afec4ad4c2039dd9524e857fcdb680ab52facc2a03ba24b294fc92c70a4ea417ad5cc1778e6687ce421c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cafd18b48924ec35bf8825381ba121b7591da1111737db53420c31c3b3f6f67b6b830746d1cffc25ca03fd87e3a27803ffef441af0342452641e8656c2f8cd41"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 10:24:04.768526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:24:04.768879) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465922130.123767-351895341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 10:24:04.853562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 10:24:04.853875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 10:24:04.854198) ========= ========= Total master_lag: 0.18 =========