builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1465980124.49 results: success (0) buildid: 20160614223005 builduid: b130ee555cd24be491604975a03eef68 revision: 683c7cabedaa562f2772c8c13e58220b5f4b01a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.492870) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.493554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.493864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.529437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.529895) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 01:42:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 124M=0s 2016-06-15 01:42:05 (124 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.665156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.665705) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.718157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:04.718673) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 683c7cabedaa562f2772c8c13e58220b5f4b01a5 --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 683c7cabedaa562f2772c8c13e58220b5f4b01a5 --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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 01:42:05,516 truncating revision to first 12 chars 2016-06-15 01:42:05,516 Setting DEBUG logging. 2016-06-15 01:42:05,516 attempt 1/10 2016-06-15 01:42:05,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/683c7cabedaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 01:42:05,822 unpacking tar archive at: mozilla-inbound-683c7cabedaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:05.383845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:05.384166) ========= script_repo_revision: 683c7cabedaa562f2772c8c13e58220b5f4b01a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:05.384584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:05.384868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 01:42:05.393428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-15 01:42:05.393816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:42:06 INFO - MultiFileLogger online at 20160615 01:42:06 in /builds/slave/test 01:42:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:42:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:42:06 INFO - {'append_to_log': False, 01:42:06 INFO - 'base_work_dir': '/builds/slave/test', 01:42:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:42:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:42:06 INFO - 'branch': 'Mozilla-Inbound', 01:42:06 INFO - 'buildbot_json_path': 'buildprops.json', 01:42:06 INFO - 'config_files': ('talos/linux_config.py',), 01:42:06 INFO - 'default_actions': ('clobber', 01:42:06 INFO - 'read-buildbot-config', 01:42:06 INFO - 'download-and-extract', 01:42:06 INFO - 'populate-webroot', 01:42:06 INFO - 'create-virtualenv', 01:42:06 INFO - 'install', 01:42:06 INFO - 'run-tests'), 01:42:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:42:06 INFO - 'download_minidump_stackwalk': True, 01:42:06 INFO - 'download_symbols': 'ondemand', 01:42:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:42:06 INFO - 'tooltool.py': '/tools/tooltool.py', 01:42:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:42:06 INFO - '/tools/misc-python/virtualenv.py')}, 01:42:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:42:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:42:06 INFO - 'installer_path': 'installer.exe', 01:42:06 INFO - 'log_level': 'info', 01:42:06 INFO - 'log_name': 'talos', 01:42:06 INFO - 'log_to_console': True, 01:42:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:42:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:42:06 INFO - 'opt_config_files': (), 01:42:06 INFO - 'pip_index': False, 01:42:06 INFO - 'sps_profile': False, 01:42:06 INFO - 'sps_profile_interval': 0, 01:42:06 INFO - 'suite': 'dromaeojs', 01:42:06 INFO - 'system_bits': '32', 01:42:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:42:06 INFO - 'title': 'talos-linux64-ix-014', 01:42:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:42:06 INFO - 'use_talos_json': True, 01:42:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:42:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:42:06 INFO - 'work_dir': 'build'} 01:42:06 INFO - ##### 01:42:06 INFO - ##### Running clobber step. 01:42:06 INFO - ##### 01:42:06 INFO - Running pre-action listener: _resource_record_pre_action 01:42:06 INFO - Running main action method: clobber 01:42:06 INFO - rmtree: /builds/slave/test/build 01:42:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:42:06 INFO - Running post-action listener: _resource_record_post_action 01:42:06 INFO - ##### 01:42:06 INFO - ##### Finished clobber step (success) 01:42:06 INFO - ##### 01:42:06 INFO - ##### 01:42:06 INFO - ##### Running read-buildbot-config step. 01:42:06 INFO - ##### 01:42:06 INFO - Running pre-action listener: _resource_record_pre_action 01:42:06 INFO - Running main action method: read_buildbot_config 01:42:06 INFO - Using buildbot properties: 01:42:06 INFO - { 01:42:06 INFO - "project": "", 01:42:06 INFO - "product": "firefox", 01:42:06 INFO - "script_repo_revision": "production", 01:42:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:42:06 INFO - "repository": "", 01:42:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:42:06 INFO - "buildid": "20160614223005", 01:42:06 INFO - "pgo_build": "True", 01:42:06 INFO - "basedir": "/builds/slave/test", 01:42:06 INFO - "buildnumber": 1181, 01:42:06 INFO - "slavename": "talos-linux64-ix-014", 01:42:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:42:06 INFO - "platform": "ubuntu64_hw", 01:42:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:42:06 INFO - "branch": "mozilla-inbound", 01:42:06 INFO - "repo_path": "integration/mozilla-inbound", 01:42:06 INFO - "revision": "683c7cabedaa562f2772c8c13e58220b5f4b01a5", 01:42:06 INFO - "stage_platform": "linux64-pgo", 01:42:06 INFO - "builduid": "b130ee555cd24be491604975a03eef68", 01:42:06 INFO - "slavebuilddir": "test" 01:42:06 INFO - } 01:42:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:42:06 INFO - Running post-action listener: _resource_record_post_action 01:42:06 INFO - ##### 01:42:06 INFO - ##### Finished read-buildbot-config step (success) 01:42:06 INFO - ##### 01:42:06 INFO - ##### 01:42:06 INFO - ##### Running download-and-extract step. 01:42:06 INFO - ##### 01:42:06 INFO - Running pre-action listener: _resource_record_pre_action 01:42:06 INFO - Running main action method: download_and_extract 01:42:06 INFO - mkdir: /builds/slave/test/build/tests 01:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:06 INFO - https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:07 INFO - Downloaded 1361 bytes. 01:42:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:07 INFO - Using the following test package requirements: 01:42:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:42:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:42:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'jsshell-linux-x86_64.zip'], 01:42:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:42:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:42:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:42:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:42:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:42:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:42:07 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')]} 01:42:07 INFO - https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:08 INFO - Downloaded 24220802 bytes. 01:42:08 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'] 01:42:08 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 01:42:09 INFO - Return code: 0 01:42:09 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 01:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:09 INFO - https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:42:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:11 INFO - Downloaded 24220802 bytes. 01:42:11 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'] 01:42:11 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 01:42:12 INFO - Return code: 0 01:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:12 INFO - https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:14 INFO - Downloaded 14405384 bytes. 01:42:14 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'] 01:42:14 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 01:42:14 INFO - Return code: 0 01:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:14 INFO - https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNbMfnaBS5ScKZAlm8fcUw/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 01:42:18 INFO - Downloaded 59383722 bytes. 01:42:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:18 INFO - mkdir: /builds/slave/test/properties 01:42:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:42:18 INFO - Writing to file /builds/slave/test/properties/build_url 01:42:18 INFO - Contents: 01:42:18 INFO - build_url:https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:19 INFO - Running post-action listener: _resource_record_post_action 01:42:19 INFO - Running post-action listener: set_extra_try_arguments 01:42:19 INFO - ##### 01:42:19 INFO - ##### Finished download-and-extract step (success) 01:42:19 INFO - ##### 01:42:19 INFO - ##### 01:42:19 INFO - ##### Running populate-webroot step. 01:42:19 INFO - ##### 01:42:19 INFO - Running pre-action listener: _resource_record_pre_action 01:42:19 INFO - Running main action method: populate_webroot 01:42:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:42:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:42:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:42:19 INFO - '--tppagecycles', 01:42:19 INFO - '7'], 01:42:19 INFO - 'tests': ['tsvgm']}}, 01:42:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:42:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:42:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:42:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:42:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['damp', 'tps']}, 01:42:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'tests': ['damp', 'tps']}, 01:42:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['dromaeo_dom']}, 01:42:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:42:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['basic_compositor_video']}, 01:42:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:42:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'other-e10s': {'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['a11yr', 01:42:19 INFO - 'ts_paint', 01:42:19 INFO - 'tpaint', 01:42:19 INFO - 'sessionrestore', 01:42:19 INFO - 'sessionrestore_no_auto_restore', 01:42:19 INFO - 'tabpaint']}, 01:42:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['tsvgx', 01:42:19 INFO - 'tsvgr_opacity', 01:42:19 INFO - 'tart', 01:42:19 INFO - 'tscrollx', 01:42:19 INFO - 'cart']}, 01:42:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:42:19 INFO - 'tsvgr_opacity', 01:42:19 INFO - 'tart', 01:42:19 INFO - 'tscrollx', 01:42:19 INFO - 'cart']}, 01:42:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'talos_options': ['--disable-e10s'], 01:42:19 INFO - 'tests': ['tp5o']}, 01:42:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'tests': ['tp5o']}, 01:42:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'talos_options': ['--disable-e10s', 01:42:19 INFO - '--xperf_path', 01:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:19 INFO - 'tests': ['tp5n']}, 01:42:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:19 INFO - 'talos_options': ['--xperf_path', 01:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:19 INFO - 'tests': ['tp5n']}}, 01:42:19 INFO - 'talos.zip': {'path': '', 01:42:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:42:19 INFO - Running post-action listener: _resource_record_post_action 01:42:19 INFO - ##### 01:42:19 INFO - ##### Finished populate-webroot step (success) 01:42:19 INFO - ##### 01:42:19 INFO - ##### 01:42:19 INFO - ##### Running create-virtualenv step. 01:42:19 INFO - ##### 01:42:19 INFO - Running pre-action listener: _resource_record_pre_action 01:42:19 INFO - Running main action method: create_virtualenv 01:42:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:42:19 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 01:42:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:42:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:42:19 INFO - Using real prefix '/usr' 01:42:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:42:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:42:22 INFO - Installing pip.................done. 01:42:22 INFO - Return code: 0 01:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:22 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:22 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 01:42:22 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 01:42:22 INFO - Using env: {'DISPLAY': ':0', 01:42:22 INFO - 'HOME': '/home/cltbld', 01:42:22 INFO - 'LANG': 'en_US.UTF-8', 01:42:22 INFO - 'LANGUAGE': 'en_US:en', 01:42:22 INFO - 'LOGNAME': 'cltbld', 01:42:22 INFO - 'MAIL': '/var/mail/cltbld', 01:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:22 INFO - 'MOZ_NO_REMOTE': '1', 01:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:22 INFO - 'NO_EM_RESTART': '1', 01:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:22 INFO - 'PWD': '/builds/slave/test', 01:42:22 INFO - 'SHELL': '/bin/bash', 01:42:22 INFO - 'SHLVL': '1', 01:42:22 INFO - 'TERM': 'linux', 01:42:22 INFO - 'TMOUT': '86400', 01:42:22 INFO - 'USER': 'cltbld', 01:42:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:22 INFO - '_': '/tools/buildbot/bin/python'} 01:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:22 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 01:42:22 INFO - Cleaning up... 01:42:22 INFO - Return code: 0 01:42:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:22 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:22 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 01:42:22 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 01:42:22 INFO - Using env: {'DISPLAY': ':0', 01:42:22 INFO - 'HOME': '/home/cltbld', 01:42:22 INFO - 'LANG': 'en_US.UTF-8', 01:42:22 INFO - 'LANGUAGE': 'en_US:en', 01:42:22 INFO - 'LOGNAME': 'cltbld', 01:42:22 INFO - 'MAIL': '/var/mail/cltbld', 01:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:22 INFO - 'MOZ_NO_REMOTE': '1', 01:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:22 INFO - 'NO_EM_RESTART': '1', 01:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:22 INFO - 'PWD': '/builds/slave/test', 01:42:22 INFO - 'SHELL': '/bin/bash', 01:42:22 INFO - 'SHLVL': '1', 01:42:22 INFO - 'TERM': 'linux', 01:42:22 INFO - 'TMOUT': '86400', 01:42:22 INFO - 'USER': 'cltbld', 01:42:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:22 INFO - '_': '/tools/buildbot/bin/python'} 01:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:22 INFO - Downloading/unpacking psutil>=3.1.1 01:42:22 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 01:42:22 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 01:42:22 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 01:42:22 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 01:42:22 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 01:42:22 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 01:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:24 INFO - Installing collected packages: psutil 01:42:24 INFO - Running setup.py install for psutil 01:42:24 INFO - building 'psutil._psutil_linux' extension 01:42:24 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 01:42:24 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 01:42:24 INFO - building 'psutil._psutil_posix' extension 01:42:24 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 01:42:24 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 01:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:25 INFO - Successfully installed psutil 01:42:25 INFO - Cleaning up... 01:42:25 INFO - Return code: 0 01:42:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:42:25 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')]} 01:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:25 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')]} 01:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:25 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:25 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 01:42:25 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 01:42:25 INFO - Using env: {'DISPLAY': ':0', 01:42:25 INFO - 'HOME': '/home/cltbld', 01:42:25 INFO - 'LANG': 'en_US.UTF-8', 01:42:25 INFO - 'LANGUAGE': 'en_US:en', 01:42:25 INFO - 'LOGNAME': 'cltbld', 01:42:25 INFO - 'MAIL': '/var/mail/cltbld', 01:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:25 INFO - 'MOZ_NO_REMOTE': '1', 01:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:25 INFO - 'NO_EM_RESTART': '1', 01:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:25 INFO - 'PWD': '/builds/slave/test', 01:42:25 INFO - 'SHELL': '/bin/bash', 01:42:25 INFO - 'SHLVL': '1', 01:42:25 INFO - 'TERM': 'linux', 01:42:25 INFO - 'TMOUT': '86400', 01:42:25 INFO - 'USER': 'cltbld', 01:42:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:25 INFO - '_': '/tools/buildbot/bin/python'} 01:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:42:25 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 01:42:25 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 01:42:25 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 01:42:25 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 01:42:25 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 01:42:25 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 01:42:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:42:27 INFO - Installing collected packages: mozsystemmonitor 01:42:27 INFO - Running setup.py install for mozsystemmonitor 01:42:27 INFO - Successfully installed mozsystemmonitor 01:42:27 INFO - Cleaning up... 01:42:27 INFO - Return code: 0 01:42:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:27 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:27 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 01:42:27 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 01:42:27 INFO - Using env: {'DISPLAY': ':0', 01:42:27 INFO - 'HOME': '/home/cltbld', 01:42:27 INFO - 'LANG': 'en_US.UTF-8', 01:42:27 INFO - 'LANGUAGE': 'en_US:en', 01:42:27 INFO - 'LOGNAME': 'cltbld', 01:42:27 INFO - 'MAIL': '/var/mail/cltbld', 01:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:27 INFO - 'MOZ_NO_REMOTE': '1', 01:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:27 INFO - 'NO_EM_RESTART': '1', 01:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:27 INFO - 'PWD': '/builds/slave/test', 01:42:27 INFO - 'SHELL': '/bin/bash', 01:42:27 INFO - 'SHLVL': '1', 01:42:27 INFO - 'TERM': 'linux', 01:42:27 INFO - 'TMOUT': '86400', 01:42:27 INFO - 'USER': 'cltbld', 01:42:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:27 INFO - '_': '/tools/buildbot/bin/python'} 01:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:27 INFO - Downloading/unpacking jsonschema==2.5.1 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:42:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:42:29 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 01:42:29 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 01:42:29 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 01:42:29 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 01:42:29 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 01:42:29 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 01:42:29 INFO - Downloading functools32-3.2.3-2.tar.gz 01:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:42:29 INFO - warning: no files found matching '*.txt' 01:42:29 INFO - no previously-included directories found matching 'build' 01:42:29 INFO - no previously-included directories found matching 'dist' 01:42:29 INFO - no previously-included directories found matching '.git*' 01:42:29 INFO - Installing collected packages: jsonschema, functools32 01:42:29 INFO - Running setup.py install for functools32 01:42:29 INFO - warning: no files found matching '*.txt' 01:42:29 INFO - no previously-included directories found matching 'build' 01:42:29 INFO - no previously-included directories found matching 'dist' 01:42:29 INFO - no previously-included directories found matching '.git*' 01:42:29 INFO - Successfully installed jsonschema functools32 01:42:29 INFO - Cleaning up... 01:42:29 INFO - Return code: 0 01:42:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:29 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:29 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 01:42:29 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 01:42:29 INFO - Using env: {'DISPLAY': ':0', 01:42:29 INFO - 'HOME': '/home/cltbld', 01:42:29 INFO - 'LANG': 'en_US.UTF-8', 01:42:29 INFO - 'LANGUAGE': 'en_US:en', 01:42:29 INFO - 'LOGNAME': 'cltbld', 01:42:29 INFO - 'MAIL': '/var/mail/cltbld', 01:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:29 INFO - 'MOZ_NO_REMOTE': '1', 01:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:29 INFO - 'NO_EM_RESTART': '1', 01:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:29 INFO - 'PWD': '/builds/slave/test', 01:42:29 INFO - 'SHELL': '/bin/bash', 01:42:29 INFO - 'SHLVL': '1', 01:42:29 INFO - 'TERM': 'linux', 01:42:29 INFO - 'TMOUT': '86400', 01:42:29 INFO - 'USER': 'cltbld', 01:42:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:29 INFO - '_': '/tools/buildbot/bin/python'} 01:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:42:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:42:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 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 01:42:32 INFO - Downloading docopt-0.6.1.tar.gz 01:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:42:32 INFO - Installing collected packages: blobuploader, requests, docopt 01:42:32 INFO - Running setup.py install for blobuploader 01:42:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:42:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:42:32 INFO - Running setup.py install for requests 01:42:33 INFO - Running setup.py install for docopt 01:42:33 INFO - Successfully installed blobuploader requests docopt 01:42:33 INFO - Cleaning up... 01:42:33 INFO - Return code: 0 01:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:33 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:33 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 01:42:33 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 01:42:33 INFO - Using env: {'DISPLAY': ':0', 01:42:33 INFO - 'HOME': '/home/cltbld', 01:42:33 INFO - 'LANG': 'en_US.UTF-8', 01:42:33 INFO - 'LANGUAGE': 'en_US:en', 01:42:33 INFO - 'LOGNAME': 'cltbld', 01:42:33 INFO - 'MAIL': '/var/mail/cltbld', 01:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:33 INFO - 'MOZ_NO_REMOTE': '1', 01:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:33 INFO - 'NO_EM_RESTART': '1', 01:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:33 INFO - 'PWD': '/builds/slave/test', 01:42:33 INFO - 'SHELL': '/bin/bash', 01:42:33 INFO - 'SHLVL': '1', 01:42:33 INFO - 'TERM': 'linux', 01:42:33 INFO - 'TMOUT': '86400', 01:42:33 INFO - 'USER': 'cltbld', 01:42:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:33 INFO - '_': '/tools/buildbot/bin/python'} 01:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:42:33 INFO - Running setup.py (path:/tmp/pip-DTtUGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:42:33 INFO - Running setup.py (path:/tmp/pip-2bzfEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:42:33 INFO - Running setup.py (path:/tmp/pip-9f0Ocl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:42:33 INFO - Running setup.py (path:/tmp/pip-NLSWYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:42:33 INFO - Running setup.py (path:/tmp/pip-_zMx1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:42:33 INFO - Running setup.py (path:/tmp/pip-eSVT35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:42:34 INFO - Running setup.py (path:/tmp/pip-6kE9CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:42:34 INFO - Running setup.py (path:/tmp/pip-WIDX2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:42:34 INFO - Running setup.py (path:/tmp/pip-ljbmWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:42:34 INFO - Running setup.py (path:/tmp/pip-Zp7c5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:42:34 INFO - Running setup.py (path:/tmp/pip-mS_TwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:42:34 INFO - Running setup.py (path:/tmp/pip-YT8OG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:42:34 INFO - Running setup.py (path:/tmp/pip-DEwrCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:42:34 INFO - Running setup.py (path:/tmp/pip-vilrmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:34 INFO - Running setup.py (path:/tmp/pip-IH7zTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:42:34 INFO - Running setup.py (path:/tmp/pip-cMaUmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:42:34 INFO - Running setup.py (path:/tmp/pip-vu5hXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:42:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:42:34 INFO - Running setup.py install for manifestparser 01:42:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:42:34 INFO - Running setup.py install for mozcrash 01:42:35 INFO - Running setup.py install for mozdebug 01:42:35 INFO - Running setup.py install for mozdevice 01:42:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Running setup.py install for mozfile 01:42:35 INFO - Running setup.py install for mozhttpd 01:42:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Running setup.py install for mozinfo 01:42:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Running setup.py install for mozInstall 01:42:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Running setup.py install for mozleak 01:42:35 INFO - Running setup.py install for mozlog 01:42:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:42:35 INFO - Running setup.py install for moznetwork 01:42:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Running setup.py install for mozprocess 01:42:36 INFO - Running setup.py install for mozprofile 01:42:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Running setup.py install for mozrunner 01:42:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Running setup.py install for mozscreenshot 01:42:36 INFO - Running setup.py install for moztest 01:42:36 INFO - Running setup.py install for mozversion 01:42:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:42:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:42:36 INFO - Cleaning up... 01:42:36 INFO - Return code: 0 01:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:36 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:36 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 01:42:36 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 01:42:36 INFO - Using env: {'DISPLAY': ':0', 01:42:36 INFO - 'HOME': '/home/cltbld', 01:42:36 INFO - 'LANG': 'en_US.UTF-8', 01:42:36 INFO - 'LANGUAGE': 'en_US:en', 01:42:36 INFO - 'LOGNAME': 'cltbld', 01:42:36 INFO - 'MAIL': '/var/mail/cltbld', 01:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:36 INFO - 'MOZ_NO_REMOTE': '1', 01:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:36 INFO - 'NO_EM_RESTART': '1', 01:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:36 INFO - 'PWD': '/builds/slave/test', 01:42:36 INFO - 'SHELL': '/bin/bash', 01:42:36 INFO - 'SHLVL': '1', 01:42:36 INFO - 'TERM': 'linux', 01:42:36 INFO - 'TMOUT': '86400', 01:42:36 INFO - 'USER': 'cltbld', 01:42:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:36 INFO - '_': '/tools/buildbot/bin/python'} 01:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:42:36 INFO - Running setup.py (path:/tmp/pip-dcV_sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:42:36 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)) 01:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:42:36 INFO - Running setup.py (path:/tmp/pip-TUPPHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:42:37 INFO - Running setup.py (path:/tmp/pip-jIT9DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:42:37 INFO - Running setup.py (path:/tmp/pip-x0OpUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:42:37 INFO - Running setup.py (path:/tmp/pip-g3z5Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:42:37 INFO - Running setup.py (path:/tmp/pip-yVZEQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:42:37 INFO - Running setup.py (path:/tmp/pip-fvYJy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:42:37 INFO - Running setup.py (path:/tmp/pip-wqmCLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:42:37 INFO - Running setup.py (path:/tmp/pip-l6TnFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:42:37 INFO - Running setup.py (path:/tmp/pip-SgE85y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:42:37 INFO - Running setup.py (path:/tmp/pip-7RX_S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:42:37 INFO - Running setup.py (path:/tmp/pip-2xIy3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:42:37 INFO - Running setup.py (path:/tmp/pip-T8vooE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:42:37 INFO - Running setup.py (path:/tmp/pip-hOyWJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:37 INFO - Running setup.py (path:/tmp/pip-mRYMhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:37 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)) 01:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:42:37 INFO - Running setup.py (path:/tmp/pip-Ef8Cx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:42:38 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)) 01:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:42:38 INFO - Running setup.py (path:/tmp/pip-OXfXDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:42:38 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)) 01:42:38 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)) 01:42:38 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)) 01:42:38 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)) 01:42:38 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)) 01:42:38 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)) 01:42:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:42:38 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 01:42:38 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 01:42:38 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 01:42:38 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 01:42:38 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 01:42:38 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 01:42:40 INFO - Downloading blessings-1.6.tar.gz 01:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:42:40 INFO - Installing collected packages: blessings 01:42:40 INFO - Running setup.py install for blessings 01:42:40 INFO - Successfully installed blessings 01:42:40 INFO - Cleaning up... 01:42:40 INFO - Return code: 0 01:42:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:42:40 INFO - Reading from file tmpfile_stdout 01:42:40 INFO - Current package versions: 01:42:40 INFO - argparse == 1.2.1 01:42:40 INFO - blessings == 1.6 01:42:40 INFO - blobuploader == 1.2.4 01:42:40 INFO - docopt == 0.6.1 01:42:40 INFO - functools32 == 3.2.3-2 01:42:40 INFO - jsonschema == 2.5.1 01:42:40 INFO - manifestparser == 1.1 01:42:40 INFO - mozInstall == 1.12 01:42:40 INFO - mozcrash == 0.17 01:42:40 INFO - mozdebug == 0.1 01:42:40 INFO - mozdevice == 0.48 01:42:40 INFO - mozfile == 1.2 01:42:40 INFO - mozhttpd == 0.7 01:42:40 INFO - mozinfo == 0.9 01:42:40 INFO - mozleak == 0.1 01:42:40 INFO - mozlog == 3.2 01:42:40 INFO - moznetwork == 0.27 01:42:40 INFO - mozprocess == 0.22 01:42:40 INFO - mozprofile == 0.28 01:42:40 INFO - mozrunner == 6.11 01:42:40 INFO - mozscreenshot == 0.1 01:42:40 INFO - mozsystemmonitor == 0.3 01:42:40 INFO - moztest == 0.7 01:42:40 INFO - mozversion == 1.4 01:42:40 INFO - psutil == 3.1.1 01:42:40 INFO - requests == 1.2.3 01:42:40 INFO - wsgiref == 0.1.2 01:42:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:40 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 01:42:40 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 01:42:40 INFO - Using env: {'DISPLAY': ':0', 01:42:40 INFO - 'HOME': '/home/cltbld', 01:42:40 INFO - 'LANG': 'en_US.UTF-8', 01:42:40 INFO - 'LANGUAGE': 'en_US:en', 01:42:40 INFO - 'LOGNAME': 'cltbld', 01:42:40 INFO - 'MAIL': '/var/mail/cltbld', 01:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:40 INFO - 'MOZ_NO_REMOTE': '1', 01:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:40 INFO - 'NO_EM_RESTART': '1', 01:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:40 INFO - 'PWD': '/builds/slave/test', 01:42:40 INFO - 'SHELL': '/bin/bash', 01:42:40 INFO - 'SHLVL': '1', 01:42:40 INFO - 'TERM': 'linux', 01:42:40 INFO - 'TMOUT': '86400', 01:42:40 INFO - 'USER': 'cltbld', 01:42:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:40 INFO - '_': '/tools/buildbot/bin/python'} 01:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 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)) 01:42:40 INFO - Cleaning up... 01:42:40 INFO - Return code: 0 01:42:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:40 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 01:42:40 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 01:42:40 INFO - Using env: {'DISPLAY': ':0', 01:42:40 INFO - 'HOME': '/home/cltbld', 01:42:40 INFO - 'LANG': 'en_US.UTF-8', 01:42:40 INFO - 'LANGUAGE': 'en_US:en', 01:42:40 INFO - 'LOGNAME': 'cltbld', 01:42:40 INFO - 'MAIL': '/var/mail/cltbld', 01:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:40 INFO - 'MOZ_NO_REMOTE': '1', 01:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:40 INFO - 'NO_EM_RESTART': '1', 01:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:40 INFO - 'PWD': '/builds/slave/test', 01:42:40 INFO - 'SHELL': '/bin/bash', 01:42:40 INFO - 'SHLVL': '1', 01:42:40 INFO - 'TERM': 'linux', 01:42:40 INFO - 'TMOUT': '86400', 01:42:40 INFO - 'USER': 'cltbld', 01:42:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:40 INFO - '_': '/tools/buildbot/bin/python'} 01:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:42:40 INFO - Cleaning up... 01:42:40 INFO - Return code: 0 01:42:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:40 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 0x7f7a15925f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, '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': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', '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 01:42:40 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 01:42:40 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 01:42:40 INFO - Using env: {'DISPLAY': ':0', 01:42:40 INFO - 'HOME': '/home/cltbld', 01:42:40 INFO - 'LANG': 'en_US.UTF-8', 01:42:40 INFO - 'LANGUAGE': 'en_US:en', 01:42:40 INFO - 'LOGNAME': 'cltbld', 01:42:40 INFO - 'MAIL': '/var/mail/cltbld', 01:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:40 INFO - 'MOZ_NO_REMOTE': '1', 01:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:40 INFO - 'NO_EM_RESTART': '1', 01:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:40 INFO - 'PWD': '/builds/slave/test', 01:42:40 INFO - 'SHELL': '/bin/bash', 01:42:40 INFO - 'SHLVL': '1', 01:42:40 INFO - 'TERM': 'linux', 01:42:40 INFO - 'TMOUT': '86400', 01:42:40 INFO - 'USER': 'cltbld', 01:42:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:40 INFO - '_': '/tools/buildbot/bin/python'} 01:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:41 INFO - Downloading/unpacking flake8 01:42:41 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 01:42:41 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 01:42:41 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 01:42:41 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 01:42:41 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 01:42:41 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 01:42:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:42:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:42:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:42:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:42:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:42:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:42:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:42:43 INFO - no previously-included directories found matching 'docs/_build' 01:42:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:42:43 INFO - Running setup.py install for pep8 01:42:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:42:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:42:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:42:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:42:43 INFO - no previously-included directories found matching 'docs/_build' 01:42:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:42:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:42:43 INFO - Cleaning up... 01:42:44 INFO - Return code: 0 01:42:44 INFO - Running post-action listener: _resource_record_post_action 01:42:44 INFO - Running post-action listener: _start_resource_monitoring 01:42:44 INFO - Starting resource monitoring. 01:42:44 INFO - ##### 01:42:44 INFO - ##### Finished create-virtualenv step (success) 01:42:44 INFO - ##### 01:42:44 INFO - ##### 01:42:44 INFO - ##### Running install step. 01:42:44 INFO - ##### 01:42:44 INFO - Running pre-action listener: _resource_record_pre_action 01:42:44 INFO - Running main action method: install 01:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:42:44 INFO - Reading from file tmpfile_stdout 01:42:44 INFO - Detecting whether we're running mozinstall >=1.0... 01:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:42:44 INFO - Reading from file tmpfile_stdout 01:42:44 INFO - Output received: 01:42:44 INFO - Usage: mozinstall [options] installer 01:42:44 INFO - Options: 01:42:44 INFO - -h, --help show this help message and exit 01:42:44 INFO - -d DEST, --destination=DEST 01:42:44 INFO - Directory to install application into. [default: 01:42:44 INFO - "/builds/slave/test"] 01:42:44 INFO - --app=APP Application being installed. [default: firefox] 01:42:44 INFO - mkdir: /builds/slave/test/build/application 01:42:44 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'] 01:42:44 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 01:43:01 INFO - Reading from file tmpfile_stdout 01:43:01 INFO - Output received: 01:43:01 INFO - /builds/slave/test/build/application/firefox/firefox 01:43:01 INFO - Running post-action listener: _resource_record_post_action 01:43:01 INFO - ##### 01:43:01 INFO - ##### Finished install step (success) 01:43:01 INFO - ##### 01:43:01 INFO - ##### 01:43:01 INFO - ##### Running run-tests step. 01:43:01 INFO - ##### 01:43:01 INFO - Running pre-action listener: _resource_record_pre_action 01:43:01 INFO - Running main action method: run_tests 01:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:43:01 INFO - Python 2.7.3 01:43:01 INFO - Return code: 0 01:43:01 INFO - grabbing minidump binary from tooltool 01:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:01 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 0x2d531c0>, '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 0x2d540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:43:01 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 01:43:01 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 01:43:01 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 01:43:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:01 INFO - Return code: 0 01:43:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:43:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:43:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:43:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:43:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:43:02 INFO - Return code: 0 01:43:02 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:43:02 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:43:02 INFO - Using env: {'DISPLAY': ':0', 01:43:02 INFO - 'HOME': '/home/cltbld', 01:43:02 INFO - 'LANG': 'en_US.UTF-8', 01:43:02 INFO - 'LANGUAGE': 'en_US:en', 01:43:02 INFO - 'LOGNAME': 'cltbld', 01:43:02 INFO - 'MAIL': '/var/mail/cltbld', 01:43:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:43:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:02 INFO - 'MOZ_NO_REMOTE': '1', 01:43:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:02 INFO - 'NO_EM_RESTART': '1', 01:43:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:02 INFO - 'PWD': '/builds/slave/test', 01:43:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:43:02 INFO - 'SHELL': '/bin/bash', 01:43:02 INFO - 'SHLVL': '1', 01:43:02 INFO - 'TERM': 'linux', 01:43:02 INFO - 'TMOUT': '86400', 01:43:02 INFO - 'USER': 'cltbld', 01:43:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584', 01:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:02 INFO - '_': '/tools/buildbot/bin/python'} 01:43:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:43:02 INFO - mozversion application_buildid: 20160614223005 01:43:02 INFO - mozversion application_changeset: 683c7cabedaa562f2772c8c13e58220b5f4b01a5 01:43:02 INFO - mozversion application_display_name: Nightly 01:43:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:02 INFO - mozversion application_name: Firefox 01:43:02 INFO - mozversion application_remotingname: firefox 01:43:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:43:02 INFO - mozversion application_vendor: Mozilla 01:43:02 INFO - mozversion application_version: 50.0a1 01:43:02 INFO - mozversion platform_buildid: 20160614223005 01:43:02 INFO - mozversion platform_changeset: 683c7cabedaa562f2772c8c13e58220b5f4b01a5 01:43:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:43:02 INFO - mozversion platform_version: 50.0a1 01:43:02 INFO - using testdate: 1465980182 01:43:02 INFO - actual date: 1465980182 01:43:02 INFO - starting webserver on 'localhost:44043' 01:43:02 INFO - SUITE-START | Running 2 tests 01:43:02 INFO - TEST-START | dromaeo_css 01:43:02 INFO - operating with platform_type : linux_ 01:43:02 INFO - Initialising browser for dromaeo_css test... 01:43:02 INFO - TEST-INFO | started process 30988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_5n5cE/profile http://localhost:44043/getInfo.html) 01:43:06 INFO - PROCESS | 30988 | __metrics Screen width/height:1600/1200 01:43:06 INFO - PROCESS | 30988 | colorDepth:24 01:43:06 INFO - PROCESS | 30988 | Browser inner width/height: 1024/697 01:43:06 INFO - PROCESS | 30988 | __metrics 01:43:07 INFO - PROCESS | 30988 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:07 INFO - PROCESS | 30988 | console.error: PushService: 01:43:07 INFO - PROCESS | 30988 | stateChangeProcessEnqueue: Error transitioning state 01:43:07 INFO - PROCESS | 30988 | UnknownError 01:43:08 INFO - TEST-INFO | 30988: exit 0 01:43:08 INFO - Browser initialized. 01:43:08 INFO - Running cycle 1/1 for dromaeo_css test... 01:43:08 INFO - TEST-INFO | started process 31072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_5n5cE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:20 INFO - PROCESS | 31072 | RSS: Main: 174075904 01:43:20 INFO - PROCESS | 31072 | 01:44:11 INFO - PROCESS | 31072 | 1465980251200 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] 01:46:20 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44043/tests/dromaeo/cssquery-ext.html) 01:46:21 INFO - PROCESS | 31072 | RSS: Main: 280670208 01:46:21 INFO - PROCESS | 31072 | 01:49:23 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-ext.html (next: http://localhost:44043/tests/dromaeo/cssquery-jquery.html) 01:49:24 INFO - PROCESS | 31072 | RSS: Main: 252936192 01:49:24 INFO - PROCESS | 31072 | 01:52:26 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44043/tests/dromaeo/cssquery-mootools.html) 01:52:27 INFO - PROCESS | 31072 | RSS: Main: 258310144 01:52:27 INFO - PROCESS | 31072 | 01:55:29 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44043/tests/dromaeo/cssquery-prototype.html) 01:55:29 INFO - PROCESS | 31072 | RSS: Main: 256430080 01:55:29 INFO - PROCESS | 31072 | 01:58:32 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44043/tests/dromaeo/cssquery-yui.html) 01:58:33 INFO - PROCESS | 31072 | RSS: Main: 242081792 01:58:33 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | Cycle 1(1): loaded http://localhost:44043/tests/dromaeo/cssquery-yui.html (next: http://localhost:44043/tests/dromaeo/cssquery-dojo.html) 02:01:36 INFO - PROCESS | 31072 | RSS: Main: 300236800 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | __start_tp_report 02:01:36 INFO - PROCESS | 31072 | _x_x_mozilla_page_load 02:01:36 INFO - PROCESS | 31072 | _x_x_mozilla_page_load_details 02:01:36 INFO - PROCESS | 31072 | |i|pagename|runs| 02:01:36 INFO - PROCESS | 31072 | |0;dojo.html;3129.1082041618142;3148.291634382264;3163.383140287644;3178.7615928805344;3212.807231566106;5215.947840521593;5275.446078161795;5375.408705042447;5446;5478.260434841291;5341.545968592664;5345.679259244438;5430.022595932741;5443.1835224716315;5480.424555421683;4782.04359128174;4830.7101573905675;4842.878928026792;4847.466778654345;5093.898122037557;4983.227599722049;4994.076095922248;5042.218456139304;5058.671186372874;5060.54455099041;4723.881902952437;4809.110314591794;4863.562279394871;4869.634777391674;4870.050340183666;4859.514048595148;4879.804807807684;4896.779644915988;4922.704637721712;4970.975145124251;4774.570288674036;4862.222044472867;4872.074305881871;4890.3642526471685;4903.289023091632;5228.686278823283;5348.224507446398;5356.732163391854;5358.651687640291;5427.511523962862;5779.971100144472;5783.971080144573;5803.21656576361;5804.245448091763;5808.912866307009;5603.719814009324;5768.048272035109;5817.360090390053;5841.182234487175;5847.239858818369;5499.807506737285;5512.5589952803675;5514.80698175562;5517.337919449611;5524.226608274845;6063.302720187235;6073.089036644538;6074.210352654215;6077.9392206078255;6089.847753806191;5503.669779813224;5614.606977511617;5665.3201615806365;5677.545796336283;5790.913136302959;5695.886082278331;5758.942410575841;5762.193292938992;5798.130280457881;5822.214001109796;5695.487406133468;5702;5703.201551782754;5730.5129064030025;5764.827055188351;5560.165975103686;5651.745671444794;5678.630888992285;5690.459406356389;5729.7708091676695;4400.317950717644;4403.9779801100785;4410.558944105628;4417.580329868657;4458.665600079942;3852.4221366795205;3933.7443066200603;3935.5277366716177;3962.2867883781196;3974.046228905042;5388.326459192601;5427.511523962862;5458.863528411822;5473.917891231635;5488.231647569343;5796.94203057964;5805.10020946754;5819.679917604488;5822.359540450631;5834.970825145847;5304.257403963448;5472.5621950243885;5502.58730595207;5517.972410137923;5522.779088836482;5019.272205530251;5036.672616280003;5040.2691609716385;5072.163093089673;5085.618578606619;6079.969600151971;6092.1775560299675;6096.756129754849;6098.969505152535;6104.969475152685;5540.252065971043;5680.68756218412;5719.256496655408;5756.539476841926;5824.504917082096;6093.685708195018;6095.0151978696995;6095.619703153352;6104.368208815833;6142.355052719578;5707.0583353747825;5710.714464276853;5711.000574899293;5711.771529138788;5712.800051998326;5607.186957891165;5741.942580574141;5745;5775.364709881994;5814.186013957965;5601.159826025966;5633.605647604629;5633.746481408264;5647.548196144381;5653.773849046157;5585.9720701397855;5621.381648018796;5630.774769009194;5638.830835074954;5644.266245388073;5361.865953351197;5504.091824848855;5543.473370029841;5554.777808887761;5578.386377498391;5704.11586204139;5779.971100144472;5780.537556995514;5782.306123265235;5785.768569257182;5421.1055175895535;5568.972155139199;5581.6371935824045;5591.916121258103;5599.32808063035 02:01:36 INFO - PROCESS | 31072 | |1;ext.html;580.6109906362736;618.1253526260341;624.2633692243154;626.001527563536;638.9616623002623;31459;32016.35967280656;43429.78285108574;44262.336064958974;44264.99999999992;41435.79282103593;45392.3191152133;45483.54516454835;45522.54477455225;45572.772136139276;9071.092890710926;9204.171624553788;9219.446833189997;9224.815503689922;9229.400088994194;9031.819363612756;9127.087291270853;9135.31485138614;9135.451872887616;9137.862932056025;9143.725688229364;9197.356185067014;9198.080191980815;9199.494027828467;9200.493972831491;9117;9155.13026262504;9172.2203612693;9173.266138708887;9177.174054335108;9039.412438191497;9107.453552786788;9109.817803643957;9113.498757568332;9115.635374585008;42992.35511467331;43181.35227971583;43238;43316.350254746205;43376.13247735028;3497.9825100874586;3838.500994870677;4044.959550404488;4165.812538435777;4284.014676624362;33568.83215583907;33813.32373352544;33830.830845845856;34046;35168.824155879054;4177.143685544486;4192.24539582878;4242.91514169718;4323.135372925428;4349.586789255016;341994;342995;343194;343906;344490;32666.346673066404;33271.50092748611;57950;58103.70948145232;58219;35491.29017419637;35654.46518302227;35782.463263051075;35806;35811.820940895646;13064.477420903057;13078.411471483807;13169;13176.47294108225;13176.73646527064;10722.839157412645;10816.783664326827;10816.945915270531;10818.404987725751;10823.404712740718;8219.589020548949;8280.875786863202;8282.296004839536;8364.163583641708;8398.41211115216;3168.714815666601;3186.952195717066;3206.246532064963;3211.550382946389;3243.9675603244136;1026.0406519903913;1070.7323169207698;1079.384750692098;1094.7482079121687;1109.1293334732197;32677.83661081727;32707.67292327094;32866.50700239498;33059.834700826344;33231.50152747711;1083.685731137961;1089.3028461784463;1125.8648962124598;1158.8319693644373;1181.2026881854713;16929.83070169307;17096.401625943283;17256.74114888278;17290.567735806704;17393.304267829397;612433;616294;618303;620422;620451;60681;61330.38669613336;61336.38663613396;61383.6930815352;61401.38598614046;1220.8901198891965;1318.8747069028427;1340.631326385252;1358.741839050597;1359.0690377091723;32120.35759284848;32678.836605816818;33242.501362479095;33567.83216083904;33611;50595.74702126466;51181.48818511916;51299.48700512947;51312.48687513077;51347.48652513576;421519;423615;423992;424772;428267;24881.377965551004;25383.61924571096;25722.742772572783;27707.861460692566;28099.157025289274;47852.52147478481;48441;49237;49997.75001124971;50536.494635053175;40850.387244190766;41649;42026.36960445534;43555.34666979934;44236.12492540308;42435.363469548596;42524.36213456739;42630.57369426266;42700.35949460823;42776.5722342785;40914.1817163661;41573.37639935343;41616;42374.36438453364;42901;34275;35841;36632.81683591565;37068.44397333988;37226.25547488981;26433.867830660725;27210.31974200661;27227.72772272331;27389.86305068462;27426.862865685544 02:01:36 INFO - PROCESS | 31072 | |2;jquery.html;373.985040598376;376.8360763068064;378.5230609432115;388.795882161865;393.278334256639;15345.69308613827;15392.461263855766;18575.442736717887;19991.20035198592;20597.794022059792;17972.55068623285;18934.14796334165;19866.106025228863;19875.70186447201;19966.20135194594;5559.388467268597;5820.330661973863;5840.445157710032;5863.941360586382;5867.4719275265215;4160.084781348114;5661.5187709044785;6091.543134264925;6373.936260637381;6384.680765961706;6180.103884936681;6416.165898433221;6465.612063276195;6466.579672321308;6473.708683109271;6292.4966002719675;6344.143540622026;6365.236171659408;6396.744130234832;6410.807675769711;5522.861928451821;5595.048841696921;5638.04153293941;5658.405867383948;5661.801836935688;22766.88616556923;22946;23061.19285824988;23352.883235583715;23452.413689657726;2409.7590240975937;2445.2587541062203;2532.5314816758773;2536.1757428835704;2736.370634754018;14231.928840355835;14380.856191438057;14452;14482.782758258634;14846.851531484655;1889.2254175787862;1902.7526421565108;1962.9312974045984;1970.330087770165;2024.2712623455545;56195;58190.01636008127;69183.07895326514;83744;84234.57882710609;10388.688339349832;10505.369677819355;10530.262881598215;10553;10658.467076646137;14461.566153015427;14536.491222807152;14557.563273101823;14577.854221457861;14588.270586470633;7384.778456646309;7686.192949740309;7689.231076892266;7741.61291935401;7742.8838567421535;7220.350168484862;7226.891596626055;7400.592967386845;7411.555306681508;7463.14173870001;6461.773837915651;6518.804435866931;6528.314526974695;6610.3720146586;6648.202215734143;1801.5496125968507;1820.1172431370774;1834.9266029358944;1901.8763780354232;1906.36136894142;932.8367535681228;992.4293531219578;1001.1390204424189;1044.7074819050679;1119.5297974850582;19384.2246310146;19713.901430492755;19773.307934222234;19844.801551984583;20262.392128236177;1015.4465816130079;1020.3112898793285;1030.1501261459325;1030.2324768047852;1054.530733823441;10591.152707783358;11226.6630754114;11377.37424441647;11433.771324573461;11496.252743571808;500219.98240140703;507945;508681;509895;513223;53786;85895.14104858997;86738.56630716806;88162.55918720366;89984;923.2752289452882;974.1038244814788;1013.4831236069657;1016.684827703429;1023.5036007536339;13883.722325553634;17731.468055958343;18215.180316885508;18281.634367312312;18416.723749143504;30032;40375.59624403718;41299;41492;41522.79238603788;51473.7426312881;53320.4667953331;55164.44835551593;56745;61171.38828611657;8509.531975741394;8707.253212879468;8727.040025597305;8766.605502752263;8934.061923497939;12765.872341276468;13171.60485185446;13696.383662735001;13741.450341986609;13968.161910285415;12073.939630302144;12121.636350909486;12286.385680716106;12555.74888502243;12660.366981650697;11994.220375675553;12261.632151035483;12301.569445069737;12419.565315213924;12656.810147847973;6514.869702606016;7939.960300198462;12241.326727029742;12271.385251757345;12645.810312845131;7492;7590.620468976639;8565.95717021411;8670.739877803677;8941;11652.475638596114;11719.648410547697;11866.644000679993;11882.702932426759;12048.397580120783 02:01:36 INFO - PROCESS | 31072 | |3;mootools.html;1295.4235365262462;1428.0646176754224;1466.6186791434227;1544.3436539470722;1721.4749501402068;8267.131951145133;8624.611892464838;8663.696770613029;8814.779630509225;8831.690890818823;8521.36089793265;8790.033096359395;8832.735017949455;8852.203301702846;8866.157715017063;1969.763628364591;2285.325828880484;2325.0467308403518;2349.882505874708;2350.9882450587725;2340.391498210469;2348.729896061949;2349.9647505287435;2350.8589484630893;2352.741198468167;2316.7683231676865;2323.372689373868;2338.602437585606;2339.7426283108844;2339.9883000584973;1925.5859990102126;2213.2585583829436;2234.4637287051155;2291;2292.5414917016665;2260.2654137405243;2261.276391554703;2277.0322612889454;2283.5318759654233;2286.371247906822;9191.402558833654;9256.8611470828;9262.814743705088;9266.11971862672;9288.582013809395;5074.771635276422;5297.947020529784;5300.44345343741;5301.946980530184;5339.70631615261;3262.331222099464;3331.3337332533592;3404.268082362304;3441.5181874537584;3444.844981975792;1074.3500182389698;1076.39183861119;1109.778044391117;1117.6144230240554;1118.2340097033477;12969.610911672666;13028.674283142997;13032.739345213138;13065.804012939814;13095.214287142802;4468.798904049326;4582.083583283356;4591.1965406053805;4614.676972611952;4669.579737823612;10793.190510711727;10805.459727013618;10808.459577021118;10829;10830.512626931806;5360.115580929181;5361.437049109865;5366.356037275552;5375.731213439312;5391.81128660495;4069.593040695966;4640.350350950869;4765.642576806753;4773.761311934459;4871.074495845778;3856.2094770571966;3902.2195560887367;4003.679705623543;4045.9797701011307;4060.309747342959;1268.968275793094;1286.5175559165314;1293.1465232946211;1300.0509627971633;1303.81094741262;960.313375936209;980.8724865767547;985.84719368498;986.5905649155663;999.1706883286854;5977.432143946318;6024.759009639565;6058.212432383762;6114.755409783648;6191.288001879841;467.2384014057133;470.3203870407229;476.64728101205554;480.6731422632574;481.94698583155827;4081.3061779497557;4202.3696445533415;4213.452251207324;4221.071364299849;4263.232618128766;10327.483625818679;10696.786064278827;10800.405977671146;10844;11020.724481887857;10525.736856578647;10619.522121504397;10625.84061239082;11100.500477478532;11106.278091924;8417.200365965224;8461.830763384822;8474.27968622674;8504.787380315418;8592.914070859337;5993.430624090704;6229.750809967551;6271.62370257786;6277.623342599459;6341.968290158519;9871.259655526008;10048.598056077675;10055.849162262426;10181.490925453845;10202.183825294107;9803.656872009446;10126.24053196028;10385;10463.372197668165;10541.104006159256;7607;7989.8402031960195;8201.261886430011;8229.588520574067;8346.12365701617;8976.102389760972;9082.45505269686;9106.271498280254;9176.44941303524;9185.173334399937;7857.646405911862;8051.2753852151245;8079.959600201962;8128.187181281824;8271.793205169919;7853.410994175346;7909.367250620052;7920.84158316842;7978.8005299865645;8118.553479558681;6631.3700198481065;6914.792556223321;7536.0956685198125;7597.506162099667;7631.38948884099;5248.501392367719;5272.499112584298;5278.736063196901;5310.097283461743;5392.730363481889;5181.041507321158;5215.895682086413;5311.9468805313;5323.733813309242;5329.067413202596 02:01:36 INFO - PROCESS | 31072 | |4;prototype.html;313.8383732377827;324.5164704590161;331.2431094948041;333.7663635455181;334.60349485859257;5047.217681259411;5192.71440070796;5195.974020129899;5205.453427390122;5221.086309895767;5164.793408263675;5182.300389447423;5191.195364718475;5191.351081114861;5228.581713462923;4070.9592904071023;4095.1400205956634;4095.488063992001;4107.732997355177;4122.732022418548;3917.5298964124345;3962.3065963456424;4124.401961715549;4141.088960428701;4144.461220041406;4041.333180025292;4082.4488694026372;4103.774292413916;4106.445629839964;4108.979455102721;4076.857309994151;4089.7137200396132;4107.178564287155;4133.173365326947;4149.481314835645;3369.79781213128;3664.560252769658;3694.5197124373926;3700.5929347771994;3700.9259814803554;5066.670666406709;5081.872953176163;5087.389513258433;5097.1650205925835;5100.15847385181;4624.560666736655;4646.4191976003;4650.697704649187;4651.906961860777;4681.227597446417;5258.1061219592375;5475.233467314579;5476.808311709111;5488.9725551371985;5523.834284971417;3928.253631809947;3929.7249192556246;3938.5076865391825;3950.8617198398206;3971.344728119857;5775.5957083004205;5784.050134431428;5796.449337312949;5813.273340832396;5846.766129354821;3815.294170578452;4019.015341241356;4045.3325201342036;4046.433499310099;4062.7968601570396;4074.5110586729784;4077.8164982575854;4102.364133559303;4102.405151253111;4119.340905455113;4660;4675.602573781267;4687.179743544866;4687.7656117194;4690.671652984327;5253.789848406021;5486.3690675572025;5518.2826232590305;5557.138643510262;5571.9721401392735;1314.309987256698;1343.328335832084;1352.4928151943022;1372.4921778941855;1373.4300265389752;880.264978742757;888.2671795768517;905.7328088213993;907.0068275238604;907.7140700679265;4662.7202367858035;4763.476017638057;4763.7141771493825;4774.761261936889;4781.306710526954;4904.215325547966;4950.4059512858685;4976.353074100344;5013.298138260647;5084.44071152173;4551.354073844474;4653.837115700934;4785.085965613783;4786.176156067937;4803.279508073817;2590;2656.2828036430055;2662.8668566571596;2677.4109695866878;2684.194741577519;5126.948730512721;5140.717260550631;5178.177893048222;5189.922151167735;5224.973875130676;5035.1188542005;5070.797168113234;5077.949220507821;5131.589472842164;5325.680459172462;5867.911981320283;5911.852203694942;5938.634114153682;5967.552433567586;5991.610545314627;5617.831465056055;5622.493975542221;5656.745446455002;5678;5694.886102278014;5444.782208711607;5599.552035837205;5628.155776633538;5691.630044047124;5692.893629357164;5882.205902203148;5932.970335148297;5937.406259374028;5979.4618484336615;5993.730282137401;3994.2610617035944;4013.2776100301057;4039.41428492861;4068.7355321903983;4072.3280658690983;5380.246765452762;5572.498475137257;5624.606277560531;5663.801766938137;5743.42565743439;5425.887693023;5550.38945715979;5551.195076713934;5556.472135147154;5559.8610034747835;5521.309836270466;5528.419515950767;5530.944690553043;5531.363893152339;5531.944680553304;5206.453322401093;5380.166074258496;5392.649477783932;5393.325834270716;5433.2665090213895;5459.508644222039;5474.8905021898545;5483.862903427446;5485.533729632866;5546.528545073553;5331;5337.879045400509;5346.893062138814;5362.973185134206;5415.620906536505 02:01:36 INFO - PROCESS | 31072 | |5;yui.html;759.3128218961838;760.8934749135123;785.026567056849;792.2671528835825;793.472340893306;15030.549083527498;16471.423500177498;16494.75257871133;16618.501444956655;16638.33446662132;16026.358945642189;16854.073025983565;16901.746473802872;16906.239219235133;16924.746128808078;650.9186351706037;791.7664289034734;802.0535767794;804.5494523067101;804.7424824056304;785.9842803143933;809.3767798794925;810.6352141536303;814.6008455856647;815.1807433529324;823.3454403749034;823.9340852731767;825.1171246765963;825.8183199696088;827.668932427031;682.3449488491054;819.0826274572487;820.3314298846451;821.3100995164032;823.5799742131526;613.3498491598875;614.0604874541914;616.4051690119056;618.6226401894841;618.938106189382;15551.066935983765;15692.450764223311;15710.135942523157;15776.211189440482;15871.682566348609;13601.727965440636;13859.4456221751;13968.93015534926;14213.64465888361;14256.215908125048;13053.673658158526;13270.336483175899;13382;13460.461581536727;14133;4253.48958125027;4324.416203812477;4437.29003359461;4442.067165895166;4445.222086134946;86142.56928715316;86683;86922.5653871733;90403;90473;10745.086667633183;10998.560057597766;10998.835017474745;11068.612598559012;11389.943050284695;20971.790282096983;20991.475213119487;21001.264955726478;21004.47488812792;21020.89489552573;8494.235518803214;8590.441621294596;8665.566721663892;8700.651973920973;8784.95607521971;4701.365315682339;4921.188003979375;4924.679895806761;4999.450060493343;5233.4243233244315;3575.3028159508644;3703.851845926187;3727.086863718406;3736;3739.0465431315383;640.1166390381244;650.5543702563759;661.8610091880663;666.3536369721362;672.062472850371;675.3887731602907;700.0828914122415;710.1868360726938;737.7528527943199;746.4923851780733;9425.90574094264;9574.856377154349;9638.807223855623;9868.21054315653;9891.653792117242;664.551427786252;682.3858527325447;685.8765422224047;764.9061841566502;766.6435107674957;4729.787159577759;4780.498047704941;4888.437829649564;4946.282788995575;4987;98942;103078;103479.48260258802;118519.70362074744;122753;80706;99231.50384248032;99458;100184;100458.497707511;87373;88728.55635721909;89563;90278.54860725654;90716;10054.497275136067;10293.485325733833;10365.326253793479;10455.738606534898;10479.528421220912;50434.243486347;51704.74147629238;52477;52549.7372513135;52759.736201318745;70680.29319706737;75272.24727752652;80060;81289;82356;12873.613791586267;13084.345782711016;13340.3329833506;13618.18290902549;14015.439382424589;14802.481913133419;15365.923170384076;15447.22763861825;15527.146006969726;16272.67454650924;14156;14353.497627582985;14640.70718585601;14778.63053423673;15102.848971510144;13963.441462341392;14198.574042778733;14289.071210371292;14512.419503219753;14564.49024284145;14048.227347495986;14303.21332326732;14411.855881441052;14542.563723088324;14551.126932384092;11903.166778325434;12050.939745301217;12088.274703517816;12288.754224915272;12779.04157188196;12381.62855114348;12517.812232816697;12565.685857853627;12591.559295424617;12604.87395126037 02:01:36 INFO - PROCESS | 31072 | __end_tp_report 02:01:36 INFO - PROCESS | 31072 | __start_cc_report 02:01:36 INFO - PROCESS | 31072 | _x_x_mozilla_cycle_collect,896 02:01:36 INFO - PROCESS | 31072 | __end_cc_report 02:01:36 INFO - PROCESS | 31072 | __startTimestamp1465981296392__endTimestamp 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | ------- Summary: start ------- 02:01:36 INFO - PROCESS | 31072 | Number of tests: 6 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#0] dojo.html Cycles:165 Average:5372.85 Median:5560.17 stddev:616.22 (11.1%) stddev-sans-first:592.44 02:01:36 INFO - PROCESS | 31072 | Values: 3129.1 3148.3 3163.4 3178.8 3212.8 5215.9 5275.4 5375.4 5446.0 5478.3 5341.5 5345.7 5430.0 5443.2 5480.4 4782.0 4830.7 4842.9 4847.5 5093.9 4983.2 4994.1 5042.2 5058.7 5060.5 4723.9 4809.1 4863.6 4869.6 4870.1 4859.5 4879.8 4896.8 4922.7 4971.0 4774.6 4862.2 4872.1 4890.4 4903.3 5228.7 5348.2 5356.7 5358.7 5427.5 5780.0 5784.0 5803.2 5804.2 5808.9 5603.7 5768.0 5817.4 5841.2 5847.2 5499.8 5512.6 5514.8 5517.3 5524.2 6063.3 6073.1 6074.2 6077.9 6089.8 5503.7 5614.6 5665.3 5677.5 5790.9 5695.9 5758.9 5762.2 5798.1 5822.2 5695.5 5702.0 5703.2 5730.5 5764.8 5560.2 5651.7 5678.6 5690.5 5729.8 4400.3 4404.0 4410.6 4417.6 4458.7 3852.4 3933.7 3935.5 3962.3 3974.0 5388.3 5427.5 5458.9 5473.9 5488.2 5796.9 5805.1 5819.7 5822.4 5835.0 5304.3 5472.6 5502.6 5518.0 5522.8 5019.3 5036.7 5040.3 5072.2 5085.6 6080.0 6092.2 6096.8 6099.0 6105.0 5540.3 5680.7 5719.3 5756.5 5824.5 6093.7 6095.0 6095.6 6104.4 6142.4 5707.1 5710.7 5711.0 5711.8 5712.8 5607.2 5741.9 5745.0 5775.4 5814.2 5601.2 5633.6 5633.7 5647.5 5653.8 5586.0 5621.4 5630.8 5638.8 5644.3 5361.9 5504.1 5543.5 5554.8 5578.4 5704.1 5780.0 5780.5 5782.3 5785.8 5421.1 5569.0 5581.6 5591.9 5599.3 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#1] ext.html Cycles:180 Average:60697.30 Median:23109.31 stddev:126990.48 (549.5%) stddev-sans-first:127266.51 02:01:36 INFO - PROCESS | 31072 | Values: 580.6 618.1 624.3 626.0 639.0 31459.0 32016.4 43429.8 44262.3 44265.0 41435.8 45392.3 45483.5 45522.5 45572.8 9071.1 9204.2 9219.4 9224.8 9229.4 9031.8 9127.1 9135.3 9135.5 9137.9 9143.7 9197.4 9198.1 9199.5 9200.5 9117.0 9155.1 9172.2 9173.3 9177.2 9039.4 9107.5 9109.8 9113.5 9115.6 42992.4 43181.4 43238.0 43316.4 43376.1 3498.0 3838.5 4045.0 4165.8 4284.0 33568.8 33813.3 33830.8 34046.0 35168.8 4177.1 4192.2 4242.9 4323.1 4349.6 341994.0 342995.0 343194.0 343906.0 344490.0 32666.3 33271.5 57950.0 58103.7 58219.0 35491.3 35654.5 35782.5 35806.0 35811.8 13064.5 13078.4 13169.0 13176.5 13176.7 10722.8 10816.8 10816.9 10818.4 10823.4 8219.6 8280.9 8282.3 8364.2 8398.4 3168.7 3187.0 3206.2 3211.6 3244.0 1026.0 1070.7 1079.4 1094.7 1109.1 32677.8 32707.7 32866.5 33059.8 33231.5 1083.7 1089.3 1125.9 1158.8 1181.2 16929.8 17096.4 17256.7 17290.6 17393.3 612433.0 616294.0 618303.0 620422.0 620451.0 60681.0 61330.4 61336.4 61383.7 61401.4 1220.9 1318.9 1340.6 1358.7 1359.1 32120.4 32678.8 33242.5 33567.8 33611.0 50595.7 51181.5 51299.5 51312.5 51347.5 421519.0 423615.0 423992.0 424772.0 428267.0 24881.4 25383.6 25722.7 27707.9 28099.2 47852.5 48441.0 49237.0 49997.8 50536.5 40850.4 41649.0 42026.4 43555.3 44236.1 42435.4 42524.4 42630.6 42700.4 42776.6 40914.2 41573.4 41616.0 42374.4 42901.0 34275.0 35841.0 36632.8 37068.4 37226.3 26433.9 27210.3 27227.7 27389.9 27426.9 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#2] jquery.html Cycles:180 Average:28903.01 Median:2488.90 stddev:83278.41 (3346.0%) stddev-sans-first:83484.48 02:01:36 INFO - PROCESS | 31072 | Values: 374.0 376.8 378.5 388.8 393.3 15345.7 15392.5 18575.4 19991.2 20597.8 17972.6 18934.1 19866.1 19875.7 19966.2 5559.4 5820.3 5840.4 5863.9 5867.5 4160.1 5661.5 6091.5 6373.9 6384.7 6180.1 6416.2 6465.6 6466.6 6473.7 6292.5 6344.1 6365.2 6396.7 6410.8 5522.9 5595.0 5638.0 5658.4 5661.8 22766.9 22946.0 23061.2 23352.9 23452.4 2409.8 2445.3 2532.5 2536.2 2736.4 14231.9 14380.9 14452.0 14482.8 14846.9 1889.2 1902.8 1962.9 1970.3 2024.3 56195.0 58190.0 69183.1 83744.0 84234.6 10388.7 10505.4 10530.3 10553.0 10658.5 14461.6 14536.5 14557.6 14577.9 14588.3 7384.8 7686.2 7689.2 7741.6 7742.9 7220.4 7226.9 7400.6 7411.6 7463.1 6461.8 6518.8 6528.3 6610.4 6648.2 1801.5 1820.1 1834.9 1901.9 1906.4 932.8 992.4 1001.1 1044.7 1119.5 19384.2 19713.9 19773.3 19844.8 20262.4 1015.4 1020.3 1030.2 1030.2 1054.5 10591.2 11226.7 11377.4 11433.8 11496.3 500220.0 507945.0 508681.0 509895.0 513223.0 53786.0 85895.1 86738.6 88162.6 89984.0 923.3 974.1 1013.5 1016.7 1023.5 13883.7 17731.5 18215.2 18281.6 18416.7 30032.0 40375.6 41299.0 41492.0 41522.8 51473.7 53320.5 55164.4 56745.0 61171.4 8509.5 8707.3 8727.0 8766.6 8934.1 12765.9 13171.6 13696.4 13741.5 13968.2 12073.9 12121.6 12286.4 12555.7 12660.4 11994.2 12261.6 12301.6 12419.6 12656.8 6514.9 7940.0 12241.3 12271.4 12645.8 7492.0 7590.6 8566.0 8670.7 8941.0 11652.5 11719.6 11866.6 11882.7 12048.4 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#3] mootools.html Cycles:180 Average:5898.70 Median:468.78 stddev:3425.06 (730.6%) stddev-sans-first:3417.20 02:01:36 INFO - PROCESS | 31072 | Values: 1295.4 1428.1 1466.6 1544.3 1721.5 8267.1 8624.6 8663.7 8814.8 8831.7 8521.4 8790.0 8832.7 8852.2 8866.2 1969.8 2285.3 2325.0 2349.9 2351.0 2340.4 2348.7 2350.0 2350.9 2352.7 2316.8 2323.4 2338.6 2339.7 2340.0 1925.6 2213.3 2234.5 2291.0 2292.5 2260.3 2261.3 2277.0 2283.5 2286.4 9191.4 9256.9 9262.8 9266.1 9288.6 5074.8 5297.9 5300.4 5301.9 5339.7 3262.3 3331.3 3404.3 3441.5 3444.8 1074.4 1076.4 1109.8 1117.6 1118.2 12969.6 13028.7 13032.7 13065.8 13095.2 4468.8 4582.1 4591.2 4614.7 4669.6 10793.2 10805.5 10808.5 10829.0 10830.5 5360.1 5361.4 5366.4 5375.7 5391.8 4069.6 4640.4 4765.6 4773.8 4871.1 3856.2 3902.2 4003.7 4046.0 4060.3 1269.0 1286.5 1293.1 1300.1 1303.8 960.3 980.9 985.8 986.6 999.2 5977.4 6024.8 6058.2 6114.8 6191.3 467.2 470.3 476.6 480.7 481.9 4081.3 4202.4 4213.5 4221.1 4263.2 10327.5 10696.8 10800.4 10844.0 11020.7 10525.7 10619.5 10625.8 11100.5 11106.3 8417.2 8461.8 8474.3 8504.8 8592.9 5993.4 6229.8 6271.6 6277.6 6342.0 9871.3 10048.6 10055.8 10181.5 10202.2 9803.7 10126.2 10385.0 10463.4 10541.1 7607.0 7989.8 8201.3 8229.6 8346.1 8976.1 9082.5 9106.3 9176.4 9185.2 7857.6 8051.3 8080.0 8128.2 8271.8 7853.4 7909.4 7920.8 7978.8 8118.6 6631.4 6914.8 7536.1 7597.5 7631.4 5248.5 5272.5 5278.7 5310.1 5392.7 5181.0 5215.9 5311.9 5323.7 5329.1 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#4] prototype.html Cycles:180 Average:4543.24 Median:5085.92 stddev:1344.51 (26.4%) stddev-sans-first:1310.27 02:01:36 INFO - PROCESS | 31072 | Values: 313.8 324.5 331.2 333.8 334.6 5047.2 5192.7 5196.0 5205.5 5221.1 5164.8 5182.3 5191.2 5191.4 5228.6 4071.0 4095.1 4095.5 4107.7 4122.7 3917.5 3962.3 4124.4 4141.1 4144.5 4041.3 4082.4 4103.8 4106.4 4109.0 4076.9 4089.7 4107.2 4133.2 4149.5 3369.8 3664.6 3694.5 3700.6 3700.9 5066.7 5081.9 5087.4 5097.2 5100.2 4624.6 4646.4 4650.7 4651.9 4681.2 5258.1 5475.2 5476.8 5489.0 5523.8 3928.3 3929.7 3938.5 3950.9 3971.3 5775.6 5784.1 5796.4 5813.3 5846.8 3815.3 4019.0 4045.3 4046.4 4062.8 4074.5 4077.8 4102.4 4102.4 4119.3 4660.0 4675.6 4687.2 4687.8 4690.7 5253.8 5486.4 5518.3 5557.1 5572.0 1314.3 1343.3 1352.5 1372.5 1373.4 880.3 888.3 905.7 907.0 907.7 4662.7 4763.5 4763.7 4774.8 4781.3 4904.2 4950.4 4976.4 5013.3 5084.4 4551.4 4653.8 4785.1 4786.2 4803.3 2590.0 2656.3 2662.9 2677.4 2684.2 5126.9 5140.7 5178.2 5189.9 5225.0 5035.1 5070.8 5077.9 5131.6 5325.7 5867.9 5911.9 5938.6 5967.6 5991.6 5617.8 5622.5 5656.7 5678.0 5694.9 5444.8 5599.6 5628.2 5691.6 5692.9 5882.2 5933.0 5937.4 5979.5 5993.7 3994.3 4013.3 4039.4 4068.7 4072.3 5380.2 5572.5 5624.6 5663.8 5743.4 5425.9 5550.4 5551.2 5556.5 5559.9 5521.3 5528.4 5530.9 5531.4 5531.9 5206.5 5380.2 5392.6 5393.3 5433.3 5459.5 5474.9 5483.9 5485.5 5546.5 5331.0 5337.9 5346.9 5363.0 5415.6 02:01:36 INFO - PROCESS | 31072 | 02:01:36 INFO - PROCESS | 31072 | [#5] yui.html Cycles:180 Average:21417.95 Median:4573.29 stddev:30268.45 (661.9%) stddev-sans-first:30313.61 02:01:36 INFO - PROCESS | 31072 | Values: 759.3 760.9 785.0 792.3 793.5 15030.5 16471.4 16494.8 16618.5 16638.3 16026.4 16854.1 16901.7 16906.2 16924.7 650.9 791.8 802.1 804.5 804.7 786.0 809.4 810.6 814.6 815.2 823.3 823.9 825.1 825.8 827.7 682.3 819.1 820.3 821.3 823.6 613.3 614.1 616.4 618.6 618.9 15551.1 15692.5 15710.1 15776.2 15871.7 13601.7 13859.4 13968.9 14213.6 14256.2 13053.7 13270.3 13382.0 13460.5 14133.0 4253.5 4324.4 4437.3 4442.1 4445.2 86142.6 86683.0 86922.6 90403.0 90473.0 10745.1 10998.6 10998.8 11068.6 11389.9 20971.8 20991.5 21001.3 21004.5 21020.9 8494.2 8590.4 8665.6 8700.7 8785.0 4701.4 4921.2 4924.7 4999.5 5233.4 3575.3 3703.9 3727.1 3736.0 3739.0 640.1 650.6 661.9 666.4 672.1 675.4 700.1 710.2 737.8 746.5 9425.9 9574.9 9638.8 9868.2 9891.7 664.6 682.4 685.9 764.9 766.6 4729.8 4780.5 4888.4 4946.3 4987.0 98942.0 103078.0 103479.5 118519.7 122753.0 80706.0 99231.5 99458.0 100184.0 100458.5 87373.0 88728.6 89563.0 90278.5 90716.0 10054.5 10293.5 10365.3 10455.7 10479.5 50434.2 51704.7 52477.0 52549.7 52759.7 70680.3 75272.2 80060.0 81289.0 82356.0 12873.6 13084.3 13340.3 13618.2 14015.4 14802.5 15365.9 15447.2 15527.1 16272.7 14156.0 14353.5 14640.7 14778.6 15102.8 13963.4 14198.6 14289.1 14512.4 14564.5 14048.2 14303.2 14411.9 14542.6 14551.1 11903.2 12050.9 12088.3 12288.8 12779.0 12381.6 12517.8 12565.7 12591.6 12604.9 02:01:36 INFO - PROCESS | 31072 | -------- Summary: end -------- 02:01:36 INFO - PROCESS | 31072 | 02:01:37 INFO - TEST-INFO | 31072: exit 0 02:01:37 INFO - TEST-OK | dromaeo_css | took 1114672ms 02:01:37 INFO - TEST-START | kraken 02:01:37 INFO - operating with platform_type : linux_ 02:01:37 INFO - Initialising browser for kraken test... 02:01:37 INFO - TEST-INFO | started process 31254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZzDXfS/profile http://localhost:44043/getInfo.html) 02:01:41 INFO - PROCESS | 31254 | __metrics Screen width/height:1600/1200 02:01:41 INFO - PROCESS | 31254 | colorDepth:24 02:01:41 INFO - PROCESS | 31254 | Browser inner width/height: 1024/697 02:01:41 INFO - PROCESS | 31254 | __metrics 02:01:42 INFO - PROCESS | 31254 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:01:42 INFO - PROCESS | 31254 | console.error: PushService: 02:01:42 INFO - PROCESS | 31254 | stateChangeProcessEnqueue: Error transitioning state 02:01:42 INFO - PROCESS | 31254 | UnknownError 02:01:43 INFO - TEST-INFO | 31254: exit 0 02:01:43 INFO - Browser initialized. 02:01:43 INFO - Running cycle 1/1 for kraken test... 02:01:43 INFO - TEST-INFO | started process 31333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZzDXfS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:55 INFO - PROCESS | 31333 | RSS: Main: 173903872 02:01:55 INFO - PROCESS | 31333 | 02:01:57 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44043/tests/kraken/driver.html?testName=audio-beat-detection) 02:01:58 INFO - PROCESS | 31333 | RSS: Main: 232976384 02:01:58 INFO - PROCESS | 31333 | 02:02:01 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44043/tests/kraken/driver.html?testName=audio-dft) 02:02:01 INFO - PROCESS | 31333 | RSS: Main: 221073408 02:02:01 INFO - PROCESS | 31333 | 02:02:05 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44043/tests/kraken/driver.html?testName=audio-fft) 02:02:05 INFO - PROCESS | 31333 | RSS: Main: 287232000 02:02:05 INFO - PROCESS | 31333 | 02:02:07 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44043/tests/kraken/driver.html?testName=audio-oscillator) 02:02:08 INFO - PROCESS | 31333 | RSS: Main: 197672960 02:02:08 INFO - PROCESS | 31333 | 02:02:10 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:02:11 INFO - PROCESS | 31333 | RSS: Main: 202194944 02:02:11 INFO - PROCESS | 31333 | 02:02:14 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44043/tests/kraken/driver.html?testName=imaging-darkroom) 02:02:14 INFO - PROCESS | 31333 | RSS: Main: 237477888 02:02:14 INFO - PROCESS | 31333 | 02:02:18 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44043/tests/kraken/driver.html?testName=imaging-desaturate) 02:02:18 INFO - PROCESS | 31333 | RSS: Main: 239263744 02:02:18 INFO - PROCESS | 31333 | 02:02:21 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44043/tests/kraken/driver.html?testName=json-parse-financial) 02:02:22 INFO - PROCESS | 31333 | RSS: Main: 238694400 02:02:22 INFO - PROCESS | 31333 | 02:02:23 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:02:24 INFO - PROCESS | 31333 | RSS: Main: 227381248 02:02:24 INFO - PROCESS | 31333 | 02:02:26 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:02:26 INFO - PROCESS | 31333 | RSS: Main: 230825984 02:02:26 INFO - PROCESS | 31333 | 02:02:28 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:02:29 INFO - PROCESS | 31333 | RSS: Main: 238309376 02:02:29 INFO - PROCESS | 31333 | 02:02:31 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:02:32 INFO - PROCESS | 31333 | RSS: Main: 241106944 02:02:32 INFO - PROCESS | 31333 | 02:02:35 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:02:35 INFO - PROCESS | 31333 | RSS: Main: 239190016 02:02:35 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | Cycle 1(1): loaded http://localhost:44043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44043/tests/kraken/driver.html?testName=ai-astar) 02:02:37 INFO - PROCESS | 31333 | RSS: Main: 281870336 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | __start_tp_report 02:02:37 INFO - PROCESS | 31333 | _x_x_mozilla_page_load 02:02:37 INFO - PROCESS | 31333 | _x_x_mozilla_page_load_details 02:02:37 INFO - PROCESS | 31333 | |i|pagename|runs| 02:02:37 INFO - PROCESS | 31333 | |0;ai-astar;112;105;110;110;114;111;111;111;110;110 02:02:37 INFO - PROCESS | 31333 | |1;audio-beat-detection;159;131;134;184;128;128;155;127;179;125 02:02:37 INFO - PROCESS | 31333 | |2;audio-dft;161;164;161;161;161;161;160;161;160;163 02:02:37 INFO - PROCESS | 31333 | |3;audio-fft;74;74;75;121;80;75;75;74;115;76 02:02:37 INFO - PROCESS | 31333 | |4;audio-oscillator;84;85;111;85;84;85;125;85;85;135 02:02:37 INFO - PROCESS | 31333 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;117;117;118 02:02:37 INFO - PROCESS | 31333 | |6;imaging-darkroom;145;147;145;146;146;146;145;146;145;145 02:02:37 INFO - PROCESS | 31333 | |7;imaging-desaturate;95;95;95;96;96;96;96;97;96;95 02:02:37 INFO - PROCESS | 31333 | |8;json-parse-financial;52;52;53;55;53;55;53;55;53;56 02:02:37 INFO - PROCESS | 31333 | |9;json-stringify-tinderbox;62;62;61;62;61;61;63;62;62;62 02:02:37 INFO - PROCESS | 31333 | |10;stanford-crypto-aes;83;86;79;81;80;81;81;81;109;86 02:02:37 INFO - PROCESS | 31333 | |11;stanford-crypto-ccm;125;125;122;133;119;127;127;123;129;125 02:02:37 INFO - PROCESS | 31333 | |12;stanford-crypto-pbkdf2;166;162;161;161;159;163;164;164;165;160 02:02:37 INFO - PROCESS | 31333 | |13;stanford-crypto-sha256-iterative;65;64;64;64;65;65;71;64;68;63 02:02:37 INFO - PROCESS | 31333 | __end_tp_report 02:02:37 INFO - PROCESS | 31333 | __start_cc_report 02:02:37 INFO - PROCESS | 31333 | _x_x_mozilla_cycle_collect,1673 02:02:37 INFO - PROCESS | 31333 | __end_cc_report 02:02:37 INFO - PROCESS | 31333 | __startTimestamp1465981357873__endTimestamp 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | ------- Summary: start ------- 02:02:37 INFO - PROCESS | 31333 | Number of tests: 14 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.27 (2.0%) stddev-sans-first:2.33 02:02:37 INFO - PROCESS | 31333 | Values: 112.0 105.0 110.0 110.0 114.0 111.0 111.0 111.0 110.0 110.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:144.50 stddev:22.59 (15.6%) stddev-sans-first:23.38 02:02:37 INFO - PROCESS | 31333 | Values: 159.0 131.0 134.0 184.0 128.0 128.0 155.0 127.0 179.0 125.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 02:02:37 INFO - PROCESS | 31333 | Values: 161.0 164.0 161.0 161.0 161.0 161.0 160.0 161.0 160.0 163.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:18.11 (24.2%) stddev-sans-first:18.85 02:02:37 INFO - PROCESS | 31333 | Values: 74.0 74.0 75.0 121.0 80.0 75.0 75.0 74.0 115.0 76.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:19.66 (23.1%) stddev-sans-first:20.33 02:02:37 INFO - PROCESS | 31333 | Values: 84.0 85.0 111.0 85.0 84.0 85.0 125.0 85.0 85.0 135.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:02:37 INFO - PROCESS | 31333 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:02:37 INFO - PROCESS | 31333 | Values: 145.0 147.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:02:37 INFO - PROCESS | 31333 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.42 (2.6%) stddev-sans-first:1.36 02:02:37 INFO - PROCESS | 31333 | Values: 52.0 52.0 53.0 55.0 53.0 55.0 53.0 55.0 53.0 56.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:02:37 INFO - PROCESS | 31333 | Values: 62.0 62.0 61.0 62.0 61.0 61.0 63.0 62.0 62.0 62.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.00 stddev:8.86 (10.9%) stddev-sans-first:9.37 02:02:37 INFO - PROCESS | 31333 | Values: 83.0 86.0 79.0 81.0 80.0 81.0 81.0 81.0 109.0 86.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:3.87 (3.1%) stddev-sans-first:4.10 02:02:37 INFO - PROCESS | 31333 | Values: 125.0 125.0 122.0 133.0 119.0 127.0 127.0 123.0 129.0 125.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.50 stddev:2.27 (1.4%) stddev-sans-first:2.03 02:02:37 INFO - PROCESS | 31333 | Values: 166.0 162.0 161.0 161.0 159.0 163.0 164.0 164.0 165.0 160.0 02:02:37 INFO - PROCESS | 31333 | 02:02:37 INFO - PROCESS | 31333 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 02:02:37 INFO - PROCESS | 31333 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 71.0 64.0 68.0 63.0 02:02:37 INFO - PROCESS | 31333 | -------- Summary: end -------- 02:02:37 INFO - PROCESS | 31333 | 02:02:38 INFO - TEST-INFO | 31333: exit 0 02:02:38 INFO - TEST-OK | kraken | took 61701ms 02:02:38 INFO - SUITE-END | took 1176s 02:02:39 INFO - Completed test suite (00:19:36) 02:02:39 INFO - javascript benchmark 02:02:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.1082041618142, 3148.291634382264, 3163.383140287644, 3178.7615928805344, 3212.807231566106, 5215.947840521593, 5275.446078161795, 5375.408705042447, 5446.0, 5478.260434841291, 5341.545968592664, 5345.679259244438, 5430.022595932741, 5443.1835224716315, 5480.424555421683, 4782.04359128174, 4830.7101573905675, 4842.878928026792, 4847.466778654345, 5093.898122037557, 4983.227599722049, 4994.076095922248, 5042.218456139304, 5058.671186372874, 5060.54455099041, 4723.881902952437, 4809.110314591794, 4863.562279394871, 4869.634777391674, 4870.050340183666, 4859.514048595148, 4879.804807807684, 4896.779644915988, 4922.704637721712, 4970.975145124251, 4774.570288674036, 4862.222044472867, 4872.074305881871, 4890.3642526471685, 4903.289023091632, 5228.686278823283, 5348.224507446398, 5356.732163391854, 5358.651687640291, 5427.511523962862, 5779.971100144472, 5783.971080144573, 5803.21656576361, 5804.245448091763, 5808.912866307009, 5603.719814009324, 5768.048272035109, 5817.360090390053, 5841.182234487175, 5847.239858818369, 5499.807506737285, 5512.5589952803675, 5514.80698175562, 5517.337919449611, 5524.226608274845, 6063.302720187235, 6073.089036644538, 6074.210352654215, 6077.9392206078255, 6089.847753806191, 5503.669779813224, 5614.606977511617, 5665.3201615806365, 5677.545796336283, 5790.913136302959, 5695.886082278331, 5758.942410575841, 5762.193292938992, 5798.130280457881, 5822.214001109796, 5695.487406133468, 5702.0, 5703.201551782754, 5730.5129064030025, 5764.827055188351, 5560.165975103686, 5651.745671444794, 5678.630888992285, 5690.459406356389, 5729.7708091676695, 4400.317950717644, 4403.9779801100785, 4410.558944105628, 4417.580329868657, 4458.665600079942, 3852.4221366795205, 3933.7443066200603, 3935.5277366716177, 3962.2867883781196, 3974.046228905042, 5388.326459192601, 5427.511523962862, 5458.863528411822, 5473.917891231635, 5488.231647569343, 5796.94203057964, 5805.10020946754, 5819.679917604488, 5822.359540450631, 5834.970825145847, 5304.257403963448, 5472.5621950243885, 5502.58730595207, 5517.972410137923, 5522.779088836482, 5019.272205530251, 5036.672616280003, 5040.2691609716385, 5072.163093089673, 5085.618578606619, 6079.969600151971, 6092.1775560299675, 6096.756129754849, 6098.969505152535, 6104.969475152685, 5540.252065971043, 5680.68756218412, 5719.256496655408, 5756.539476841926, 5824.504917082096, 6093.685708195018, 6095.0151978696995, 6095.619703153352, 6104.368208815833, 6142.355052719578, 5707.0583353747825, 5710.714464276853, 5711.000574899293, 5711.771529138788, 5712.800051998326, 5607.186957891165, 5741.942580574141, 5745.0, 5775.364709881994, 5814.186013957965, 5601.159826025966, 5633.605647604629, 5633.746481408264, 5647.548196144381, 5653.773849046157, 5585.9720701397855, 5621.381648018796, 5630.774769009194, 5638.830835074954, 5644.266245388073, 5361.865953351197, 5504.091824848855, 5543.473370029841, 5554.777808887761, 5578.386377498391, 5704.11586204139, 5779.971100144472, 5780.537556995514, 5782.306123265235, 5785.768569257182, 5421.1055175895535, 5568.972155139199, 5581.6371935824045, 5591.916121258103, 5599.32808063035], "value": 5331.341359395766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6109906362736, 618.1253526260341, 624.2633692243154, 626.001527563536, 638.9616623002623, 31459.0, 32016.35967280656, 43429.78285108574, 44262.336064958974, 44264.99999999992, 41435.79282103593, 45392.3191152133, 45483.54516454835, 45522.54477455225, 45572.772136139276, 9071.092890710926, 9204.171624553788, 9219.446833189997, 9224.815503689922, 9229.400088994194, 9031.819363612756, 9127.087291270853, 9135.31485138614, 9135.451872887616, 9137.862932056025, 9143.725688229364, 9197.356185067014, 9198.080191980815, 9199.494027828467, 9200.493972831491, 9117.0, 9155.13026262504, 9172.2203612693, 9173.266138708887, 9177.174054335108, 9039.412438191497, 9107.453552786788, 9109.817803643957, 9113.498757568332, 9115.635374585008, 42992.35511467331, 43181.35227971583, 43238.0, 43316.350254746205, 43376.13247735028, 3497.9825100874586, 3838.500994870677, 4044.959550404488, 4165.812538435777, 4284.014676624362, 33568.83215583907, 33813.32373352544, 33830.830845845856, 34046.0, 35168.824155879054, 4177.143685544486, 4192.24539582878, 4242.91514169718, 4323.135372925428, 4349.586789255016, 341994.0, 342995.0, 343194.0, 343906.0, 344490.0, 32666.346673066404, 33271.50092748611, 57950.0, 58103.70948145232, 58219.0, 35491.29017419637, 35654.46518302227, 35782.463263051075, 35806.0, 35811.820940895646, 13064.477420903057, 13078.411471483807, 13169.0, 13176.47294108225, 13176.73646527064, 10722.839157412645, 10816.783664326827, 10816.945915270531, 10818.404987725751, 10823.404712740718, 8219.589020548949, 8280.875786863202, 8282.296004839536, 8364.163583641708, 8398.41211115216, 3168.714815666601, 3186.952195717066, 3206.246532064963, 3211.550382946389, 3243.9675603244136, 1026.0406519903913, 1070.7323169207698, 1079.384750692098, 1094.7482079121687, 1109.1293334732197, 32677.83661081727, 32707.67292327094, 32866.50700239498, 33059.834700826344, 33231.50152747711, 1083.685731137961, 1089.3028461784463, 1125.8648962124598, 1158.8319693644373, 1181.2026881854713, 16929.83070169307, 17096.401625943283, 17256.74114888278, 17290.567735806704, 17393.304267829397, 612433.0, 616294.0, 618303.0, 620422.0, 620451.0, 60681.0, 61330.38669613336, 61336.38663613396, 61383.6930815352, 61401.38598614046, 1220.8901198891965, 1318.8747069028427, 1340.631326385252, 1358.741839050597, 1359.0690377091723, 32120.35759284848, 32678.836605816818, 33242.501362479095, 33567.83216083904, 33611.0, 50595.74702126466, 51181.48818511916, 51299.48700512947, 51312.48687513077, 51347.48652513576, 421519.0, 423615.0, 423992.0, 424772.0, 428267.0, 24881.377965551004, 25383.61924571096, 25722.742772572783, 27707.861460692566, 28099.157025289274, 47852.52147478481, 48441.0, 49237.0, 49997.75001124971, 50536.494635053175, 40850.387244190766, 41649.0, 42026.36960445534, 43555.34666979934, 44236.12492540308, 42435.363469548596, 42524.36213456739, 42630.57369426266, 42700.35949460823, 42776.5722342785, 40914.1817163661, 41573.37639935343, 41616.0, 42374.36438453364, 42901.0, 34275.0, 35841.0, 36632.81683591565, 37068.44397333988, 37226.25547488981, 26433.867830660725, 27210.31974200661, 27227.72772272331, 27389.86305068462, 27426.862865685544], "value": 18908.884833480017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.985040598376, 376.8360763068064, 378.5230609432115, 388.795882161865, 393.278334256639, 15345.69308613827, 15392.461263855766, 18575.442736717887, 19991.20035198592, 20597.794022059792, 17972.55068623285, 18934.14796334165, 19866.106025228863, 19875.70186447201, 19966.20135194594, 5559.388467268597, 5820.330661973863, 5840.445157710032, 5863.941360586382, 5867.4719275265215, 4160.084781348114, 5661.5187709044785, 6091.543134264925, 6373.936260637381, 6384.680765961706, 6180.103884936681, 6416.165898433221, 6465.612063276195, 6466.579672321308, 6473.708683109271, 6292.4966002719675, 6344.143540622026, 6365.236171659408, 6396.744130234832, 6410.807675769711, 5522.861928451821, 5595.048841696921, 5638.04153293941, 5658.405867383948, 5661.801836935688, 22766.88616556923, 22946.0, 23061.19285824988, 23352.883235583715, 23452.413689657726, 2409.7590240975937, 2445.2587541062203, 2532.5314816758773, 2536.1757428835704, 2736.370634754018, 14231.928840355835, 14380.856191438057, 14452.0, 14482.782758258634, 14846.851531484655, 1889.2254175787862, 1902.7526421565108, 1962.9312974045984, 1970.330087770165, 2024.2712623455545, 56195.0, 58190.01636008127, 69183.07895326514, 83744.0, 84234.57882710609, 10388.688339349832, 10505.369677819355, 10530.262881598215, 10553.0, 10658.467076646137, 14461.566153015427, 14536.491222807152, 14557.563273101823, 14577.854221457861, 14588.270586470633, 7384.778456646309, 7686.192949740309, 7689.231076892266, 7741.61291935401, 7742.8838567421535, 7220.350168484862, 7226.891596626055, 7400.592967386845, 7411.555306681508, 7463.14173870001, 6461.773837915651, 6518.804435866931, 6528.314526974695, 6610.3720146586, 6648.202215734143, 1801.5496125968507, 1820.1172431370774, 1834.9266029358944, 1901.8763780354232, 1906.36136894142, 932.8367535681228, 992.4293531219578, 1001.1390204424189, 1044.7074819050679, 1119.5297974850582, 19384.2246310146, 19713.901430492755, 19773.307934222234, 19844.801551984583, 20262.392128236177, 1015.4465816130079, 1020.3112898793285, 1030.1501261459325, 1030.2324768047852, 1054.530733823441, 10591.152707783358, 11226.6630754114, 11377.37424441647, 11433.771324573461, 11496.252743571808, 500219.98240140703, 507945.0, 508681.0, 509895.0, 513223.0, 53786.0, 85895.14104858997, 86738.56630716806, 88162.55918720366, 89984.0, 923.2752289452882, 974.1038244814788, 1013.4831236069657, 1016.684827703429, 1023.5036007536339, 13883.722325553634, 17731.468055958343, 18215.180316885508, 18281.634367312312, 18416.723749143504, 30032.0, 40375.59624403718, 41299.0, 41492.0, 41522.79238603788, 51473.7426312881, 53320.4667953331, 55164.44835551593, 56745.0, 61171.38828611657, 8509.531975741394, 8707.253212879468, 8727.040025597305, 8766.605502752263, 8934.061923497939, 12765.872341276468, 13171.60485185446, 13696.383662735001, 13741.450341986609, 13968.161910285415, 12073.939630302144, 12121.636350909486, 12286.385680716106, 12555.74888502243, 12660.366981650697, 11994.220375675553, 12261.632151035483, 12301.569445069737, 12419.565315213924, 12656.810147847973, 6514.869702606016, 7939.960300198462, 12241.326727029742, 12271.385251757345, 12645.810312845131, 7492.0, 7590.620468976639, 8565.95717021411, 8670.739877803677, 8941.0, 11652.475638596114, 11719.648410547697, 11866.644000679993, 11882.702932426759, 12048.397580120783], "value": 9318.608599524736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.4235365262462, 1428.0646176754224, 1466.6186791434227, 1544.3436539470722, 1721.4749501402068, 8267.131951145133, 8624.611892464838, 8663.696770613029, 8814.779630509225, 8831.690890818823, 8521.36089793265, 8790.033096359395, 8832.735017949455, 8852.203301702846, 8866.157715017063, 1969.763628364591, 2285.325828880484, 2325.0467308403518, 2349.882505874708, 2350.9882450587725, 2340.391498210469, 2348.729896061949, 2349.9647505287435, 2350.8589484630893, 2352.741198468167, 2316.7683231676865, 2323.372689373868, 2338.602437585606, 2339.7426283108844, 2339.9883000584973, 1925.5859990102126, 2213.2585583829436, 2234.4637287051155, 2291.0, 2292.5414917016665, 2260.2654137405243, 2261.276391554703, 2277.0322612889454, 2283.5318759654233, 2286.371247906822, 9191.402558833654, 9256.8611470828, 9262.814743705088, 9266.11971862672, 9288.582013809395, 5074.771635276422, 5297.947020529784, 5300.44345343741, 5301.946980530184, 5339.70631615261, 3262.331222099464, 3331.3337332533592, 3404.268082362304, 3441.5181874537584, 3444.844981975792, 1074.3500182389698, 1076.39183861119, 1109.778044391117, 1117.6144230240554, 1118.2340097033477, 12969.610911672666, 13028.674283142997, 13032.739345213138, 13065.804012939814, 13095.214287142802, 4468.798904049326, 4582.083583283356, 4591.1965406053805, 4614.676972611952, 4669.579737823612, 10793.190510711727, 10805.459727013618, 10808.459577021118, 10829.0, 10830.512626931806, 5360.115580929181, 5361.437049109865, 5366.356037275552, 5375.731213439312, 5391.81128660495, 4069.593040695966, 4640.350350950869, 4765.642576806753, 4773.761311934459, 4871.074495845778, 3856.2094770571966, 3902.2195560887367, 4003.679705623543, 4045.9797701011307, 4060.309747342959, 1268.968275793094, 1286.5175559165314, 1293.1465232946211, 1300.0509627971633, 1303.81094741262, 960.313375936209, 980.8724865767547, 985.84719368498, 986.5905649155663, 999.1706883286854, 5977.432143946318, 6024.759009639565, 6058.212432383762, 6114.755409783648, 6191.288001879841, 467.2384014057133, 470.3203870407229, 476.64728101205554, 480.6731422632574, 481.94698583155827, 4081.3061779497557, 4202.3696445533415, 4213.452251207324, 4221.071364299849, 4263.232618128766, 10327.483625818679, 10696.786064278827, 10800.405977671146, 10844.0, 11020.724481887857, 10525.736856578647, 10619.522121504397, 10625.84061239082, 11100.500477478532, 11106.278091924, 8417.200365965224, 8461.830763384822, 8474.27968622674, 8504.787380315418, 8592.914070859337, 5993.430624090704, 6229.750809967551, 6271.62370257786, 6277.623342599459, 6341.968290158519, 9871.259655526008, 10048.598056077675, 10055.849162262426, 10181.490925453845, 10202.183825294107, 9803.656872009446, 10126.24053196028, 10385.0, 10463.372197668165, 10541.104006159256, 7607.0, 7989.8402031960195, 8201.261886430011, 8229.588520574067, 8346.12365701617, 8976.102389760972, 9082.45505269686, 9106.271498280254, 9176.44941303524, 9185.173334399937, 7857.646405911862, 8051.2753852151245, 8079.959600201962, 8128.187181281824, 8271.793205169919, 7853.410994175346, 7909.367250620052, 7920.84158316842, 7978.8005299865645, 8118.553479558681, 6631.3700198481065, 6914.792556223321, 7536.0956685198125, 7597.506162099667, 7631.38948884099, 5248.501392367719, 5272.499112584298, 5278.736063196901, 5310.097283461743, 5392.730363481889, 5181.041507321158, 5215.895682086413, 5311.9468805313, 5323.733813309242, 5329.067413202596], "value": 4604.871871937087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8383732377827, 324.5164704590161, 331.2431094948041, 333.7663635455181, 334.60349485859257, 5047.217681259411, 5192.71440070796, 5195.974020129899, 5205.453427390122, 5221.086309895767, 5164.793408263675, 5182.300389447423, 5191.195364718475, 5191.351081114861, 5228.581713462923, 4070.9592904071023, 4095.1400205956634, 4095.488063992001, 4107.732997355177, 4122.732022418548, 3917.5298964124345, 3962.3065963456424, 4124.401961715549, 4141.088960428701, 4144.461220041406, 4041.333180025292, 4082.4488694026372, 4103.774292413916, 4106.445629839964, 4108.979455102721, 4076.857309994151, 4089.7137200396132, 4107.178564287155, 4133.173365326947, 4149.481314835645, 3369.79781213128, 3664.560252769658, 3694.5197124373926, 3700.5929347771994, 3700.9259814803554, 5066.670666406709, 5081.872953176163, 5087.389513258433, 5097.1650205925835, 5100.15847385181, 4624.560666736655, 4646.4191976003, 4650.697704649187, 4651.906961860777, 4681.227597446417, 5258.1061219592375, 5475.233467314579, 5476.808311709111, 5488.9725551371985, 5523.834284971417, 3928.253631809947, 3929.7249192556246, 3938.5076865391825, 3950.8617198398206, 3971.344728119857, 5775.5957083004205, 5784.050134431428, 5796.449337312949, 5813.273340832396, 5846.766129354821, 3815.294170578452, 4019.015341241356, 4045.3325201342036, 4046.433499310099, 4062.7968601570396, 4074.5110586729784, 4077.8164982575854, 4102.364133559303, 4102.405151253111, 4119.340905455113, 4660.0, 4675.602573781267, 4687.179743544866, 4687.7656117194, 4690.671652984327, 5253.789848406021, 5486.3690675572025, 5518.2826232590305, 5557.138643510262, 5571.9721401392735, 1314.309987256698, 1343.328335832084, 1352.4928151943022, 1372.4921778941855, 1373.4300265389752, 880.264978742757, 888.2671795768517, 905.7328088213993, 907.0068275238604, 907.7140700679265, 4662.7202367858035, 4763.476017638057, 4763.7141771493825, 4774.761261936889, 4781.306710526954, 4904.215325547966, 4950.4059512858685, 4976.353074100344, 5013.298138260647, 5084.44071152173, 4551.354073844474, 4653.837115700934, 4785.085965613783, 4786.176156067937, 4803.279508073817, 2590.0, 2656.2828036430055, 2662.8668566571596, 2677.4109695866878, 2684.194741577519, 5126.948730512721, 5140.717260550631, 5178.177893048222, 5189.922151167735, 5224.973875130676, 5035.1188542005, 5070.797168113234, 5077.949220507821, 5131.589472842164, 5325.680459172462, 5867.911981320283, 5911.852203694942, 5938.634114153682, 5967.552433567586, 5991.610545314627, 5617.831465056055, 5622.493975542221, 5656.745446455002, 5678.0, 5694.886102278014, 5444.782208711607, 5599.552035837205, 5628.155776633538, 5691.630044047124, 5692.893629357164, 5882.205902203148, 5932.970335148297, 5937.406259374028, 5979.4618484336615, 5993.730282137401, 3994.2610617035944, 4013.2776100301057, 4039.41428492861, 4068.7355321903983, 4072.3280658690983, 5380.246765452762, 5572.498475137257, 5624.606277560531, 5663.801766938137, 5743.42565743439, 5425.887693023, 5550.38945715979, 5551.195076713934, 5556.472135147154, 5559.8610034747835, 5521.309836270466, 5528.419515950767, 5530.944690553043, 5531.363893152339, 5531.944680553304, 5206.453322401093, 5380.166074258496, 5392.649477783932, 5393.325834270716, 5433.2665090213895, 5459.508644222039, 5474.8905021898545, 5483.862903427446, 5485.533729632866, 5546.528545073553, 5331.0, 5337.879045400509, 5346.893062138814, 5362.973185134206, 5415.620906536505], "value": 4113.010558475468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3128218961838, 760.8934749135123, 785.026567056849, 792.2671528835825, 793.472340893306, 15030.549083527498, 16471.423500177498, 16494.75257871133, 16618.501444956655, 16638.33446662132, 16026.358945642189, 16854.073025983565, 16901.746473802872, 16906.239219235133, 16924.746128808078, 650.9186351706037, 791.7664289034734, 802.0535767794, 804.5494523067101, 804.7424824056304, 785.9842803143933, 809.3767798794925, 810.6352141536303, 814.6008455856647, 815.1807433529324, 823.3454403749034, 823.9340852731767, 825.1171246765963, 825.8183199696088, 827.668932427031, 682.3449488491054, 819.0826274572487, 820.3314298846451, 821.3100995164032, 823.5799742131526, 613.3498491598875, 614.0604874541914, 616.4051690119056, 618.6226401894841, 618.938106189382, 15551.066935983765, 15692.450764223311, 15710.135942523157, 15776.211189440482, 15871.682566348609, 13601.727965440636, 13859.4456221751, 13968.93015534926, 14213.64465888361, 14256.215908125048, 13053.673658158526, 13270.336483175899, 13382.0, 13460.461581536727, 14133.0, 4253.48958125027, 4324.416203812477, 4437.29003359461, 4442.067165895166, 4445.222086134946, 86142.56928715316, 86683.0, 86922.5653871733, 90403.0, 90473.0, 10745.086667633183, 10998.560057597766, 10998.835017474745, 11068.612598559012, 11389.943050284695, 20971.790282096983, 20991.475213119487, 21001.264955726478, 21004.47488812792, 21020.89489552573, 8494.235518803214, 8590.441621294596, 8665.566721663892, 8700.651973920973, 8784.95607521971, 4701.365315682339, 4921.188003979375, 4924.679895806761, 4999.450060493343, 5233.4243233244315, 3575.3028159508644, 3703.851845926187, 3727.086863718406, 3736.0, 3739.0465431315383, 640.1166390381244, 650.5543702563759, 661.8610091880663, 666.3536369721362, 672.062472850371, 675.3887731602907, 700.0828914122415, 710.1868360726938, 737.7528527943199, 746.4923851780733, 9425.90574094264, 9574.856377154349, 9638.807223855623, 9868.21054315653, 9891.653792117242, 664.551427786252, 682.3858527325447, 685.8765422224047, 764.9061841566502, 766.6435107674957, 4729.787159577759, 4780.498047704941, 4888.437829649564, 4946.282788995575, 4987.0, 98942.0, 103078.0, 103479.48260258802, 118519.70362074744, 122753.0, 80706.0, 99231.50384248032, 99458.0, 100184.0, 100458.497707511, 87373.0, 88728.55635721909, 89563.0, 90278.54860725654, 90716.0, 10054.497275136067, 10293.485325733833, 10365.326253793479, 10455.738606534898, 10479.528421220912, 50434.243486347, 51704.74147629238, 52477.0, 52549.7372513135, 52759.736201318745, 70680.29319706737, 75272.24727752652, 80060.0, 81289.0, 82356.0, 12873.613791586267, 13084.345782711016, 13340.3329833506, 13618.18290902549, 14015.439382424589, 14802.481913133419, 15365.923170384076, 15447.22763861825, 15527.146006969726, 16272.67454650924, 14156.0, 14353.497627582985, 14640.70718585601, 14778.63053423673, 15102.848971510144, 13963.441462341392, 14198.574042778733, 14289.071210371292, 14512.419503219753, 14564.49024284145, 14048.227347495986, 14303.21332326732, 14411.855881441052, 14542.563723088324, 14551.126932384092, 11903.166778325434, 12050.939745301217, 12088.274703517816, 12288.754224915272, 12779.04157188196, 12381.62855114348, 12517.812232816697, 12565.685857853627, 12591.559295424617, 12604.87395126037], "value": 7803.785977751439, "unit": "score"}], "name": "dromaeo_css", "value": 7196.093182512036, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 110.0, 114.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 134.0, 184.0, 128.0, 128.0, 155.0, 127.0, 179.0, 125.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 80.0, 75.0, 75.0, 74.0, 115.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 85.0, 84.0, 85.0, 125.0, 85.0, 85.0, 135.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 55.0, 53.0, 55.0, 53.0, 55.0, 53.0, 56.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 79.0, 81.0, 80.0, 81.0, 81.0, 81.0, 109.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 122.0, 133.0, 119.0, 127.0, 127.0, 123.0, 129.0, 125.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 161.0, 161.0, 159.0, 163.0, 164.0, 164.0, 165.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 71.0, 64.0, 68.0, 63.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1509.2, "alertThreshold": 2.0}]} 02:02:39 INFO - Return code: 0 02:02:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:02:39 INFO - # TBPL SUCCESS # 02:02:39 INFO - Running post-action listener: _resource_record_post_action 02:02:39 INFO - ##### 02:02:39 INFO - ##### Finished run-tests step (success) 02:02:39 INFO - ##### 02:02:39 INFO - Running post-run listener: _resource_record_post_run 02:02:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 547930112; Read time: 196; Write time: 453564 02:02:39 INFO - TinderboxPrint: CPU usage
13.2% 02:02:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 196 02:02:39 INFO - TinderboxPrint: I/O write bytes / time
547,930,112 / 453,564 02:02:39 INFO - TinderboxPrint: CPU idle
8,274.2 (86.8%) 02:02:39 INFO - TinderboxPrint: CPU user
1,213.0 (12.7%) 02:02:39 INFO - TinderboxPrint: Swap in / out
0 / 0 02:02:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254320640; Read time: 0; Write time: 234944 02:02:39 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293609472; Read time: 196; Write time: 218620 02:02:39 INFO - Running post-run listener: _upload_blobber_files 02:02:39 INFO - Blob upload gear active. 02:02:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:02:39 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 02:02:39 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'] 02:02:39 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 02:02:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:02:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:02:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:02:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:02:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:02:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:02:40 INFO - (blobuploader) - INFO - Done attempting. 02:02:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:02:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:02:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:02:45 INFO - (blobuploader) - INFO - Done attempting. 02:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:02:46 INFO - (blobuploader) - INFO - Done attempting. 02:02:46 INFO - (blobuploader) - INFO - Iteration through files over. 02:02:46 INFO - Return code: 0 02:02:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:02:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:02:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1715c1749b05f2b9424d2cd4d136cd99b9492e3f62db110238cdced3d1360ec89587730dda2e5b0b45b6ad7294fff7809c21b1de0c7eaf3d7b7e3ee54a92dad0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27f1c8431a28f907b55d00fb427914eb2db35996e5a0d6c843d159f0fbb3f32b8e4d8aa5859857786b6658e2b8e0d9e2b315c1c320a59d9bec7317648ebabf02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0654edeb7eaeec8ee3bc91e9cad9d77a3ced7610fcee11f4237b80e708c9fe2699ae5ebe0f9af21d1b8464e7c2a3c8ccdacbb2114f9fcd461c783c2763f766fa"} 02:02:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:02:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:02:46 INFO - Contents: 02:02:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1715c1749b05f2b9424d2cd4d136cd99b9492e3f62db110238cdced3d1360ec89587730dda2e5b0b45b6ad7294fff7809c21b1de0c7eaf3d7b7e3ee54a92dad0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27f1c8431a28f907b55d00fb427914eb2db35996e5a0d6c843d159f0fbb3f32b8e4d8aa5859857786b6658e2b8e0d9e2b315c1c320a59d9bec7317648ebabf02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0654edeb7eaeec8ee3bc91e9cad9d77a3ced7610fcee11f4237b80e708c9fe2699ae5ebe0f9af21d1b8464e7c2a3c8ccdacbb2114f9fcd461c783c2763f766fa"} 02:02:46 INFO - Running post-run listener: copy_logs_to_upload_dir 02:02:46 INFO - Copying logs to upload dir... 02:02:46 INFO - mkdir: /builds/slave/test/build/upload/logs 02:02:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.169195 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-15 02:02:45.580944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 02:02:45.584879) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1715c1749b05f2b9424d2cd4d136cd99b9492e3f62db110238cdced3d1360ec89587730dda2e5b0b45b6ad7294fff7809c21b1de0c7eaf3d7b7e3ee54a92dad0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27f1c8431a28f907b55d00fb427914eb2db35996e5a0d6c843d159f0fbb3f32b8e4d8aa5859857786b6658e2b8e0d9e2b315c1c320a59d9bec7317648ebabf02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0654edeb7eaeec8ee3bc91e9cad9d77a3ced7610fcee11f4237b80e708c9fe2699ae5ebe0f9af21d1b8464e7c2a3c8ccdacbb2114f9fcd461c783c2763f766fa"} build_url:https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/WNbMfnaBS5ScKZAlm8fcUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1715c1749b05f2b9424d2cd4d136cd99b9492e3f62db110238cdced3d1360ec89587730dda2e5b0b45b6ad7294fff7809c21b1de0c7eaf3d7b7e3ee54a92dad0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27f1c8431a28f907b55d00fb427914eb2db35996e5a0d6c843d159f0fbb3f32b8e4d8aa5859857786b6658e2b8e0d9e2b315c1c320a59d9bec7317648ebabf02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0654edeb7eaeec8ee3bc91e9cad9d77a3ced7610fcee11f4237b80e708c9fe2699ae5ebe0f9af21d1b8464e7c2a3c8ccdacbb2114f9fcd461c783c2763f766fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 02:02:45.610810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:02:45.611210) ========= 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=31acecf42b6a79ec49471d4a000001bb-1465974229.181334-1489150584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:02:45.696336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 02:02:45.696667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 02:02:45.696981) ========= ========= Total master_lag: 0.18 =========