builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1465762599.03 results: success (0) buildid: 20160612103048 builduid: f7f80fbf0754444f8647d156c96963f3 revision: d1722ce2542a2dcc6d351da7481640aceb44f894 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.028563) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.029024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.029771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.070324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.070621) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 13:16:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 222M=0s 2016-06-12 13:16:39 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.247686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.247964) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.298392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:39.298711) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d1722ce2542a2dcc6d351da7481640aceb44f894 --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 d1722ce2542a2dcc6d351da7481640aceb44f894 --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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 13:16:39,779 truncating revision to first 12 chars 2016-06-12 13:16:39,779 Setting DEBUG logging. 2016-06-12 13:16:39,779 attempt 1/10 2016-06-12 13:16:39,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d1722ce2542a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 13:16:40,248 unpacking tar archive at: mozilla-inbound-d1722ce2542a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:40.128274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:40.128616) ========= script_repo_revision: d1722ce2542a2dcc6d351da7481640aceb44f894 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:40.129014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:40.129305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 13:16:40.138450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-12 13:16:40.138787) ========= /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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:16:40 INFO - MultiFileLogger online at 20160612 13:16:40 in /builds/slave/test 13:16:40 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 13:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:40 INFO - {'append_to_log': False, 13:16:40 INFO - 'base_work_dir': '/builds/slave/test', 13:16:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:40 INFO - 'branch': 'Mozilla-Inbound', 13:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:40 INFO - 'config_files': ('talos/linux_config.py',), 13:16:40 INFO - 'default_actions': ('clobber', 13:16:40 INFO - 'read-buildbot-config', 13:16:40 INFO - 'download-and-extract', 13:16:40 INFO - 'populate-webroot', 13:16:40 INFO - 'create-virtualenv', 13:16:40 INFO - 'install', 13:16:40 INFO - 'run-tests'), 13:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:40 INFO - 'download_minidump_stackwalk': True, 13:16:40 INFO - 'download_symbols': 'ondemand', 13:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:40 INFO - 'installer_path': 'installer.exe', 13:16:40 INFO - 'log_level': 'info', 13:16:40 INFO - 'log_name': 'talos', 13:16:40 INFO - 'log_to_console': True, 13:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:16:40 INFO - 'opt_config_files': (), 13:16:40 INFO - 'pip_index': False, 13:16:40 INFO - 'sps_profile': False, 13:16:40 INFO - 'sps_profile_interval': 0, 13:16:40 INFO - 'suite': 'dromaeojs', 13:16:40 INFO - 'system_bits': '32', 13:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:40 INFO - 'title': 'talos-linux64-ix-002', 13:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:40 INFO - 'use_talos_json': True, 13:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:40 INFO - 'work_dir': 'build'} 13:16:40 INFO - ##### 13:16:40 INFO - ##### Running clobber step. 13:16:40 INFO - ##### 13:16:40 INFO - Running pre-action listener: _resource_record_pre_action 13:16:40 INFO - Running main action method: clobber 13:16:40 INFO - rmtree: /builds/slave/test/build 13:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:41 INFO - Running post-action listener: _resource_record_post_action 13:16:41 INFO - ##### 13:16:41 INFO - ##### Finished clobber step (success) 13:16:41 INFO - ##### 13:16:41 INFO - ##### 13:16:41 INFO - ##### Running read-buildbot-config step. 13:16:41 INFO - ##### 13:16:41 INFO - Running pre-action listener: _resource_record_pre_action 13:16:41 INFO - Running main action method: read_buildbot_config 13:16:41 INFO - Using buildbot properties: 13:16:41 INFO - { 13:16:41 INFO - "project": "", 13:16:41 INFO - "product": "firefox", 13:16:41 INFO - "script_repo_revision": "production", 13:16:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:16:41 INFO - "repository": "", 13:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:16:41 INFO - "buildid": "20160612103048", 13:16:41 INFO - "pgo_build": "True", 13:16:41 INFO - "basedir": "/builds/slave/test", 13:16:41 INFO - "buildnumber": 1917, 13:16:41 INFO - "slavename": "talos-linux64-ix-002", 13:16:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:16:41 INFO - "platform": "ubuntu64_hw", 13:16:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:16:41 INFO - "branch": "mozilla-inbound", 13:16:41 INFO - "repo_path": "integration/mozilla-inbound", 13:16:41 INFO - "revision": "d1722ce2542a2dcc6d351da7481640aceb44f894", 13:16:41 INFO - "stage_platform": "linux64-pgo", 13:16:41 INFO - "builduid": "f7f80fbf0754444f8647d156c96963f3", 13:16:41 INFO - "slavebuilddir": "test" 13:16:41 INFO - } 13:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:16:41 INFO - Running post-action listener: _resource_record_post_action 13:16:41 INFO - ##### 13:16:41 INFO - ##### Finished read-buildbot-config step (success) 13:16:41 INFO - ##### 13:16:41 INFO - ##### 13:16:41 INFO - ##### Running download-and-extract step. 13:16:41 INFO - ##### 13:16:41 INFO - Running pre-action listener: _resource_record_pre_action 13:16:41 INFO - Running main action method: download_and_extract 13:16:41 INFO - mkdir: /builds/slave/test/build/tests 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:41 INFO - Downloaded 1361 bytes. 13:16:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:41 INFO - Using the following test package requirements: 13:16:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:16:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:16:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'jsshell-linux-x86_64.zip'], 13:16:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:16:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:16:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:16:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:16:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:16:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:42 INFO - Downloaded 24217897 bytes. 13:16:42 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'] 13:16:42 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 13:16:44 INFO - Return code: 0 13:16:44 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 13:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:44 INFO - https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:48 INFO - Downloaded 24217897 bytes. 13:16:48 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'] 13:16:48 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 13:16:50 INFO - Return code: 0 13:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:50 INFO - https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:51 INFO - Downloaded 14405384 bytes. 13:16:51 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'] 13:16:51 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 13:16:51 INFO - Return code: 0 13:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:51 INFO - https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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 13:16:53 INFO - Downloaded 59339048 bytes. 13:16:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:53 INFO - mkdir: /builds/slave/test/properties 13:16:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:53 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:53 INFO - Contents: 13:16:53 INFO - build_url:https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:54 INFO - Running post-action listener: _resource_record_post_action 13:16:54 INFO - Running post-action listener: set_extra_try_arguments 13:16:54 INFO - ##### 13:16:54 INFO - ##### Finished download-and-extract step (success) 13:16:54 INFO - ##### 13:16:54 INFO - ##### 13:16:54 INFO - ##### Running populate-webroot step. 13:16:54 INFO - ##### 13:16:54 INFO - Running pre-action listener: _resource_record_pre_action 13:16:54 INFO - Running main action method: populate_webroot 13:16:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:16:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:16:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:16:54 INFO - '--tppagecycles', 13:16:54 INFO - '7'], 13:16:54 INFO - 'tests': ['tsvgm']}}, 13:16:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:16:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:16:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['damp', 'tps']}, 13:16:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'tests': ['damp', 'tps']}, 13:16:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['dromaeo_dom']}, 13:16:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['basic_compositor_video']}, 13:16:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:16:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['a11yr', 13:16:54 INFO - 'ts_paint', 13:16:54 INFO - 'tpaint', 13:16:54 INFO - 'sessionrestore', 13:16:54 INFO - 'sessionrestore_no_auto_restore', 13:16:54 INFO - 'tabpaint']}, 13:16:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['tsvgx', 13:16:54 INFO - 'tsvgr_opacity', 13:16:54 INFO - 'tart', 13:16:54 INFO - 'tscrollx', 13:16:54 INFO - 'cart']}, 13:16:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:54 INFO - 'tsvgr_opacity', 13:16:54 INFO - 'tart', 13:16:54 INFO - 'tscrollx', 13:16:54 INFO - 'cart']}, 13:16:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'talos_options': ['--disable-e10s'], 13:16:54 INFO - 'tests': ['tp5o']}, 13:16:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'tests': ['tp5o']}, 13:16:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'talos_options': ['--disable-e10s', 13:16:54 INFO - '--xperf_path', 13:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:54 INFO - 'tests': ['tp5n']}, 13:16:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:54 INFO - 'talos_options': ['--xperf_path', 13:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:54 INFO - 'tests': ['tp5n']}}, 13:16:54 INFO - 'talos.zip': {'path': '', 13:16:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:16:54 INFO - Running post-action listener: _resource_record_post_action 13:16:54 INFO - ##### 13:16:54 INFO - ##### Finished populate-webroot step (success) 13:16:54 INFO - ##### 13:16:54 INFO - ##### 13:16:54 INFO - ##### Running create-virtualenv step. 13:16:54 INFO - ##### 13:16:54 INFO - Running pre-action listener: _resource_record_pre_action 13:16:54 INFO - Running main action method: create_virtualenv 13:16:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:16:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:16:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:54 INFO - Using real prefix '/usr' 13:16:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:57 INFO - Installing pip.................done. 13:16:57 INFO - Return code: 0 13:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:57 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:16:57 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 13:16:57 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 13:16:57 INFO - Using env: {'DISPLAY': ':0', 13:16:57 INFO - 'HOME': '/home/cltbld', 13:16:57 INFO - 'LANG': 'en_US.UTF-8', 13:16:57 INFO - 'LANGUAGE': 'en_US:en', 13:16:57 INFO - 'LOGNAME': 'cltbld', 13:16:57 INFO - 'MAIL': '/var/mail/cltbld', 13:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:57 INFO - 'MOZ_NO_REMOTE': '1', 13:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:57 INFO - 'NO_EM_RESTART': '1', 13:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:57 INFO - 'PWD': '/builds/slave/test', 13:16:57 INFO - 'SHELL': '/bin/bash', 13:16:57 INFO - 'SHLVL': '1', 13:16:57 INFO - 'TERM': 'linux', 13:16:57 INFO - 'TMOUT': '86400', 13:16:57 INFO - 'USER': 'cltbld', 13:16:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:57 INFO - '_': '/tools/buildbot/bin/python'} 13:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:16:57 INFO - Cleaning up... 13:16:57 INFO - Return code: 0 13:16:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:57 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:16:57 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 13:16:57 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 13:16:57 INFO - Using env: {'DISPLAY': ':0', 13:16:57 INFO - 'HOME': '/home/cltbld', 13:16:57 INFO - 'LANG': 'en_US.UTF-8', 13:16:57 INFO - 'LANGUAGE': 'en_US:en', 13:16:57 INFO - 'LOGNAME': 'cltbld', 13:16:57 INFO - 'MAIL': '/var/mail/cltbld', 13:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:57 INFO - 'MOZ_NO_REMOTE': '1', 13:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:57 INFO - 'NO_EM_RESTART': '1', 13:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:57 INFO - 'PWD': '/builds/slave/test', 13:16:57 INFO - 'SHELL': '/bin/bash', 13:16:57 INFO - 'SHLVL': '1', 13:16:57 INFO - 'TERM': 'linux', 13:16:57 INFO - 'TMOUT': '86400', 13:16:57 INFO - 'USER': 'cltbld', 13:16:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:57 INFO - '_': '/tools/buildbot/bin/python'} 13:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:57 INFO - Downloading/unpacking psutil>=3.1.1 13:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:59 INFO - Installing collected packages: psutil 13:16:59 INFO - Running setup.py install for psutil 13:16:59 INFO - building 'psutil._psutil_linux' extension 13:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:16:59 INFO - building 'psutil._psutil_posix' extension 13:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:59 INFO - Successfully installed psutil 13:16:59 INFO - Cleaning up... 13:17:00 INFO - Return code: 0 13:17:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:00 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:00 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 13:17:00 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 13:17:00 INFO - Using env: {'DISPLAY': ':0', 13:17:00 INFO - 'HOME': '/home/cltbld', 13:17:00 INFO - 'LANG': 'en_US.UTF-8', 13:17:00 INFO - 'LANGUAGE': 'en_US:en', 13:17:00 INFO - 'LOGNAME': 'cltbld', 13:17:00 INFO - 'MAIL': '/var/mail/cltbld', 13:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:00 INFO - 'MOZ_NO_REMOTE': '1', 13:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:00 INFO - 'NO_EM_RESTART': '1', 13:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:00 INFO - 'PWD': '/builds/slave/test', 13:17:00 INFO - 'SHELL': '/bin/bash', 13:17:00 INFO - 'SHLVL': '1', 13:17:00 INFO - 'TERM': 'linux', 13:17:00 INFO - 'TMOUT': '86400', 13:17:00 INFO - 'USER': 'cltbld', 13:17:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:00 INFO - '_': '/tools/buildbot/bin/python'} 13:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:02 INFO - Installing collected packages: mozsystemmonitor 13:17:02 INFO - Running setup.py install for mozsystemmonitor 13:17:02 INFO - Successfully installed mozsystemmonitor 13:17:02 INFO - Cleaning up... 13:17:02 INFO - Return code: 0 13:17:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:17:02 INFO - Using env: {'DISPLAY': ':0', 13:17:02 INFO - 'HOME': '/home/cltbld', 13:17:02 INFO - 'LANG': 'en_US.UTF-8', 13:17:02 INFO - 'LANGUAGE': 'en_US:en', 13:17:02 INFO - 'LOGNAME': 'cltbld', 13:17:02 INFO - 'MAIL': '/var/mail/cltbld', 13:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:02 INFO - 'MOZ_NO_REMOTE': '1', 13:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:02 INFO - 'NO_EM_RESTART': '1', 13:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:02 INFO - 'PWD': '/builds/slave/test', 13:17:02 INFO - 'SHELL': '/bin/bash', 13:17:02 INFO - 'SHLVL': '1', 13:17:02 INFO - 'TERM': 'linux', 13:17:02 INFO - 'TMOUT': '86400', 13:17:02 INFO - 'USER': 'cltbld', 13:17:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:02 INFO - '_': '/tools/buildbot/bin/python'} 13:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:02 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:04 INFO - warning: no files found matching '*.txt' 13:17:04 INFO - no previously-included directories found matching 'build' 13:17:04 INFO - no previously-included directories found matching 'dist' 13:17:04 INFO - no previously-included directories found matching '.git*' 13:17:04 INFO - Installing collected packages: jsonschema, functools32 13:17:04 INFO - Running setup.py install for functools32 13:17:04 INFO - warning: no files found matching '*.txt' 13:17:04 INFO - no previously-included directories found matching 'build' 13:17:04 INFO - no previously-included directories found matching 'dist' 13:17:04 INFO - no previously-included directories found matching '.git*' 13:17:04 INFO - Successfully installed jsonschema functools32 13:17:04 INFO - Cleaning up... 13:17:04 INFO - Return code: 0 13:17:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:04 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:04 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 13:17:04 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 13:17:04 INFO - Using env: {'DISPLAY': ':0', 13:17:04 INFO - 'HOME': '/home/cltbld', 13:17:04 INFO - 'LANG': 'en_US.UTF-8', 13:17:04 INFO - 'LANGUAGE': 'en_US:en', 13:17:04 INFO - 'LOGNAME': 'cltbld', 13:17:04 INFO - 'MAIL': '/var/mail/cltbld', 13:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:04 INFO - 'MOZ_NO_REMOTE': '1', 13:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:04 INFO - 'NO_EM_RESTART': '1', 13:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:04 INFO - 'PWD': '/builds/slave/test', 13:17:04 INFO - 'SHELL': '/bin/bash', 13:17:04 INFO - 'SHLVL': '1', 13:17:04 INFO - 'TERM': 'linux', 13:17:04 INFO - 'TMOUT': '86400', 13:17:04 INFO - 'USER': 'cltbld', 13:17:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:04 INFO - '_': '/tools/buildbot/bin/python'} 13:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:06 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 13:17:06 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 13:17:06 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 13:17:06 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 13:17:06 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 13:17:06 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 13:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:07 INFO - Downloading docopt-0.6.1.tar.gz 13:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:07 INFO - Running setup.py install for blobuploader 13:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:07 INFO - Running setup.py install for requests 13:17:08 INFO - Running setup.py install for docopt 13:17:08 INFO - Successfully installed blobuploader requests docopt 13:17:08 INFO - Cleaning up... 13:17:08 INFO - Return code: 0 13:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:08 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:08 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 13:17:08 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 13:17:08 INFO - Using env: {'DISPLAY': ':0', 13:17:08 INFO - 'HOME': '/home/cltbld', 13:17:08 INFO - 'LANG': 'en_US.UTF-8', 13:17:08 INFO - 'LANGUAGE': 'en_US:en', 13:17:08 INFO - 'LOGNAME': 'cltbld', 13:17:08 INFO - 'MAIL': '/var/mail/cltbld', 13:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:08 INFO - 'MOZ_NO_REMOTE': '1', 13:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:08 INFO - 'NO_EM_RESTART': '1', 13:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:08 INFO - 'PWD': '/builds/slave/test', 13:17:08 INFO - 'SHELL': '/bin/bash', 13:17:08 INFO - 'SHLVL': '1', 13:17:08 INFO - 'TERM': 'linux', 13:17:08 INFO - 'TMOUT': '86400', 13:17:08 INFO - 'USER': 'cltbld', 13:17:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:08 INFO - '_': '/tools/buildbot/bin/python'} 13:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:08 INFO - Running setup.py (path:/tmp/pip-vE_vbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:08 INFO - Running setup.py (path:/tmp/pip-DFAaWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:08 INFO - Running setup.py (path:/tmp/pip-fXCOAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:08 INFO - Running setup.py (path:/tmp/pip-VnYmJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:08 INFO - Running setup.py (path:/tmp/pip-sY3WeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:08 INFO - Running setup.py (path:/tmp/pip-WIQFtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:08 INFO - Running setup.py (path:/tmp/pip-RnFhRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:08 INFO - Running setup.py (path:/tmp/pip-fkcHHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:09 INFO - Running setup.py (path:/tmp/pip-NpQGut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:09 INFO - Running setup.py (path:/tmp/pip-ZE5SNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:09 INFO - Running setup.py (path:/tmp/pip-aATT4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:09 INFO - Running setup.py (path:/tmp/pip-Gm8iTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:09 INFO - Running setup.py (path:/tmp/pip-cwxBkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:09 INFO - Running setup.py (path:/tmp/pip-Gv8bpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:09 INFO - Running setup.py (path:/tmp/pip-M1me2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:09 INFO - Running setup.py (path:/tmp/pip-1LwmXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:09 INFO - Running setup.py (path:/tmp/pip-pRx_Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:09 INFO - Running setup.py install for manifestparser 13:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:09 INFO - Running setup.py install for mozcrash 13:17:09 INFO - Running setup.py install for mozdebug 13:17:09 INFO - Running setup.py install for mozdevice 13:17:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for mozfile 13:17:10 INFO - Running setup.py install for mozhttpd 13:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for mozinfo 13:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for mozInstall 13:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for mozleak 13:17:10 INFO - Running setup.py install for mozlog 13:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for moznetwork 13:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:10 INFO - Running setup.py install for mozprocess 13:17:10 INFO - Running setup.py install for mozprofile 13:17:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:11 INFO - Running setup.py install for mozrunner 13:17:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:11 INFO - Running setup.py install for mozscreenshot 13:17:11 INFO - Running setup.py install for moztest 13:17:11 INFO - Running setup.py install for mozversion 13:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:11 INFO - Cleaning up... 13:17:11 INFO - Return code: 0 13:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:11 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:11 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 13:17:11 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 13:17:11 INFO - Using env: {'DISPLAY': ':0', 13:17:11 INFO - 'HOME': '/home/cltbld', 13:17:11 INFO - 'LANG': 'en_US.UTF-8', 13:17:11 INFO - 'LANGUAGE': 'en_US:en', 13:17:11 INFO - 'LOGNAME': 'cltbld', 13:17:11 INFO - 'MAIL': '/var/mail/cltbld', 13:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:11 INFO - 'MOZ_NO_REMOTE': '1', 13:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:11 INFO - 'NO_EM_RESTART': '1', 13:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:11 INFO - 'PWD': '/builds/slave/test', 13:17:11 INFO - 'SHELL': '/bin/bash', 13:17:11 INFO - 'SHLVL': '1', 13:17:11 INFO - 'TERM': 'linux', 13:17:11 INFO - 'TMOUT': '86400', 13:17:11 INFO - 'USER': 'cltbld', 13:17:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:11 INFO - '_': '/tools/buildbot/bin/python'} 13:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:11 INFO - Running setup.py (path:/tmp/pip-9jhL0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:11 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)) 13:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:11 INFO - Running setup.py (path:/tmp/pip-zEMd1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:11 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)) 13:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:11 INFO - Running setup.py (path:/tmp/pip-cbWNAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:11 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)) 13:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:11 INFO - Running setup.py (path:/tmp/pip-UOFUs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:11 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)) 13:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:11 INFO - Running setup.py (path:/tmp/pip-Rt1bNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:12 INFO - Running setup.py (path:/tmp/pip-WZSt9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:12 INFO - Running setup.py (path:/tmp/pip-31uUML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:12 INFO - Running setup.py (path:/tmp/pip-CAet5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:12 INFO - Running setup.py (path:/tmp/pip-5Gip1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:12 INFO - Running setup.py (path:/tmp/pip-YgNGiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:12 INFO - Running setup.py (path:/tmp/pip-rm9Bqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:12 INFO - Running setup.py (path:/tmp/pip-hdwvxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:12 INFO - Running setup.py (path:/tmp/pip-aCfRZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:12 INFO - Running setup.py (path:/tmp/pip-hxlsO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:12 INFO - Running setup.py (path:/tmp/pip-dB8Qf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:12 INFO - Running setup.py (path:/tmp/pip-waxVrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:12 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)) 13:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:12 INFO - Running setup.py (path:/tmp/pip-lVRiVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:15 INFO - Downloading blessings-1.6.tar.gz 13:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:15 INFO - Installing collected packages: blessings 13:17:15 INFO - Running setup.py install for blessings 13:17:15 INFO - Successfully installed blessings 13:17:15 INFO - Cleaning up... 13:17:15 INFO - Return code: 0 13:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:15 INFO - Reading from file tmpfile_stdout 13:17:15 INFO - Current package versions: 13:17:15 INFO - argparse == 1.2.1 13:17:15 INFO - blessings == 1.6 13:17:15 INFO - blobuploader == 1.2.4 13:17:15 INFO - docopt == 0.6.1 13:17:15 INFO - functools32 == 3.2.3-2 13:17:15 INFO - jsonschema == 2.5.1 13:17:15 INFO - manifestparser == 1.1 13:17:15 INFO - mozInstall == 1.12 13:17:15 INFO - mozcrash == 0.17 13:17:15 INFO - mozdebug == 0.1 13:17:15 INFO - mozdevice == 0.48 13:17:15 INFO - mozfile == 1.2 13:17:15 INFO - mozhttpd == 0.7 13:17:15 INFO - mozinfo == 0.9 13:17:15 INFO - mozleak == 0.1 13:17:15 INFO - mozlog == 3.2 13:17:15 INFO - moznetwork == 0.27 13:17:15 INFO - mozprocess == 0.22 13:17:15 INFO - mozprofile == 0.28 13:17:15 INFO - mozrunner == 6.11 13:17:15 INFO - mozscreenshot == 0.1 13:17:15 INFO - mozsystemmonitor == 0.3 13:17:15 INFO - moztest == 0.7 13:17:15 INFO - mozversion == 1.4 13:17:15 INFO - psutil == 3.1.1 13:17:15 INFO - requests == 1.2.3 13:17:15 INFO - wsgiref == 0.1.2 13:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:15 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 13:17:15 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 13:17:15 INFO - Using env: {'DISPLAY': ':0', 13:17:15 INFO - 'HOME': '/home/cltbld', 13:17:15 INFO - 'LANG': 'en_US.UTF-8', 13:17:15 INFO - 'LANGUAGE': 'en_US:en', 13:17:15 INFO - 'LOGNAME': 'cltbld', 13:17:15 INFO - 'MAIL': '/var/mail/cltbld', 13:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:15 INFO - 'MOZ_NO_REMOTE': '1', 13:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:15 INFO - 'NO_EM_RESTART': '1', 13:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:15 INFO - 'PWD': '/builds/slave/test', 13:17:15 INFO - 'SHELL': '/bin/bash', 13:17:15 INFO - 'SHLVL': '1', 13:17:15 INFO - 'TERM': 'linux', 13:17:15 INFO - 'TMOUT': '86400', 13:17:15 INFO - 'USER': 'cltbld', 13:17:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:15 INFO - '_': '/tools/buildbot/bin/python'} 13:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:15 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)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:17:15 INFO - Cleaning up... 13:17:15 INFO - Return code: 0 13:17:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:15 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 13:17:15 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 13:17:15 INFO - Using env: {'DISPLAY': ':0', 13:17:15 INFO - 'HOME': '/home/cltbld', 13:17:15 INFO - 'LANG': 'en_US.UTF-8', 13:17:15 INFO - 'LANGUAGE': 'en_US:en', 13:17:15 INFO - 'LOGNAME': 'cltbld', 13:17:15 INFO - 'MAIL': '/var/mail/cltbld', 13:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:15 INFO - 'MOZ_NO_REMOTE': '1', 13:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:15 INFO - 'NO_EM_RESTART': '1', 13:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:15 INFO - 'PWD': '/builds/slave/test', 13:17:15 INFO - 'SHELL': '/bin/bash', 13:17:15 INFO - 'SHLVL': '1', 13:17:15 INFO - 'TERM': 'linux', 13:17:15 INFO - 'TMOUT': '86400', 13:17:15 INFO - 'USER': 'cltbld', 13:17:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:15 INFO - '_': '/tools/buildbot/bin/python'} 13:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:15 INFO - Cleaning up... 13:17:15 INFO - Return code: 0 13:17:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:15 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 0x7f4273290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', '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 13:17:15 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 13:17:15 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 13:17:15 INFO - Using env: {'DISPLAY': ':0', 13:17:15 INFO - 'HOME': '/home/cltbld', 13:17:15 INFO - 'LANG': 'en_US.UTF-8', 13:17:15 INFO - 'LANGUAGE': 'en_US:en', 13:17:15 INFO - 'LOGNAME': 'cltbld', 13:17:15 INFO - 'MAIL': '/var/mail/cltbld', 13:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:15 INFO - 'MOZ_NO_REMOTE': '1', 13:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:15 INFO - 'NO_EM_RESTART': '1', 13:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:15 INFO - 'PWD': '/builds/slave/test', 13:17:15 INFO - 'SHELL': '/bin/bash', 13:17:15 INFO - 'SHLVL': '1', 13:17:15 INFO - 'TERM': 'linux', 13:17:15 INFO - 'TMOUT': '86400', 13:17:15 INFO - 'USER': 'cltbld', 13:17:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:15 INFO - '_': '/tools/buildbot/bin/python'} 13:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:16 INFO - Downloading/unpacking flake8 13:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:17:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:17:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:18 INFO - no previously-included directories found matching 'docs/_build' 13:17:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:17:18 INFO - Running setup.py install for pep8 13:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:18 INFO - no previously-included directories found matching 'docs/_build' 13:17:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:17:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:17:18 INFO - Cleaning up... 13:17:18 INFO - Return code: 0 13:17:18 INFO - Running post-action listener: _resource_record_post_action 13:17:18 INFO - Running post-action listener: _start_resource_monitoring 13:17:19 INFO - Starting resource monitoring. 13:17:19 INFO - ##### 13:17:19 INFO - ##### Finished create-virtualenv step (success) 13:17:19 INFO - ##### 13:17:19 INFO - ##### 13:17:19 INFO - ##### Running install step. 13:17:19 INFO - ##### 13:17:19 INFO - Running pre-action listener: _resource_record_pre_action 13:17:19 INFO - Running main action method: install 13:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:19 INFO - Reading from file tmpfile_stdout 13:17:19 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:19 INFO - Reading from file tmpfile_stdout 13:17:19 INFO - Output received: 13:17:19 INFO - Usage: mozinstall [options] installer 13:17:19 INFO - Options: 13:17:19 INFO - -h, --help show this help message and exit 13:17:19 INFO - -d DEST, --destination=DEST 13:17:19 INFO - Directory to install application into. [default: 13:17:19 INFO - "/builds/slave/test"] 13:17:19 INFO - --app=APP Application being installed. [default: firefox] 13:17:19 INFO - mkdir: /builds/slave/test/build/application 13:17:19 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'] 13:17:19 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 13:17:36 INFO - Reading from file tmpfile_stdout 13:17:36 INFO - Output received: 13:17:36 INFO - /builds/slave/test/build/application/firefox/firefox 13:17:36 INFO - Running post-action listener: _resource_record_post_action 13:17:36 INFO - ##### 13:17:36 INFO - ##### Finished install step (success) 13:17:36 INFO - ##### 13:17:36 INFO - ##### 13:17:36 INFO - ##### Running run-tests step. 13:17:36 INFO - ##### 13:17:36 INFO - Running pre-action listener: _resource_record_pre_action 13:17:36 INFO - Running main action method: run_tests 13:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:36 INFO - Python 2.7.3 13:17:36 INFO - Return code: 0 13:17:36 INFO - grabbing minidump binary from tooltool 13:17: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')]} 13:17:36 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 0x10d81c0>, '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 0x10d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:36 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 13:17:36 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 13:17:36 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 13:17:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:36 INFO - Return code: 0 13:17:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:17:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:17:37 INFO - Return code: 0 13:17:37 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/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:17:37 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/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 13:17:37 INFO - Using env: {'DISPLAY': ':0', 13:17:37 INFO - 'HOME': '/home/cltbld', 13:17:37 INFO - 'LANG': 'en_US.UTF-8', 13:17:37 INFO - 'LANGUAGE': 'en_US:en', 13:17:37 INFO - 'LOGNAME': 'cltbld', 13:17:37 INFO - 'MAIL': '/var/mail/cltbld', 13:17:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:37 INFO - 'MOZ_NO_REMOTE': '1', 13:17:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:37 INFO - 'NO_EM_RESTART': '1', 13:17:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:37 INFO - 'PWD': '/builds/slave/test', 13:17:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:37 INFO - 'SHELL': '/bin/bash', 13:17:37 INFO - 'SHLVL': '1', 13:17:37 INFO - 'TERM': 'linux', 13:17:37 INFO - 'TMOUT': '86400', 13:17:37 INFO - 'USER': 'cltbld', 13:17:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379', 13:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:37 INFO - '_': '/tools/buildbot/bin/python'} 13:17:37 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/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:17:37 INFO - mozversion application_buildid: 20160612103048 13:17:37 INFO - mozversion application_changeset: d1722ce2542a2dcc6d351da7481640aceb44f894 13:17:37 INFO - mozversion application_display_name: Nightly 13:17:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:37 INFO - mozversion application_name: Firefox 13:17:37 INFO - mozversion application_remotingname: firefox 13:17:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:17:37 INFO - mozversion application_vendor: Mozilla 13:17:37 INFO - mozversion application_version: 50.0a1 13:17:37 INFO - mozversion platform_buildid: 20160612103048 13:17:37 INFO - mozversion platform_changeset: d1722ce2542a2dcc6d351da7481640aceb44f894 13:17:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:17:37 INFO - mozversion platform_version: 50.0a1 13:17:37 INFO - using testdate: 1465762657 13:17:37 INFO - actual date: 1465762657 13:17:37 INFO - starting webserver on 'localhost:48509' 13:17:37 INFO - SUITE-START | Running 2 tests 13:17:37 INFO - TEST-START | dromaeo_css 13:17:37 INFO - operating with platform_type : linux_ 13:17:37 INFO - Initialising browser for dromaeo_css test... 13:17:37 INFO - TEST-INFO | started process 7096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCS4rn/profile http://localhost:48509/getInfo.html) 13:17:41 INFO - PROCESS | 7096 | __metrics Screen width/height:1600/1200 13:17:41 INFO - PROCESS | 7096 | colorDepth:24 13:17:41 INFO - PROCESS | 7096 | Browser inner width/height: 1024/697 13:17:41 INFO - PROCESS | 7096 | __metrics 13:17:42 INFO - PROCESS | 7096 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:42 INFO - PROCESS | 7096 | console.error: PushService: 13:17:42 INFO - PROCESS | 7096 | stateChangeProcessEnqueue: Error transitioning state 13:17:42 INFO - PROCESS | 7096 | UnknownError 13:17:43 INFO - TEST-INFO | 7096: exit 0 13:17:43 INFO - Browser initialized. 13:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:43 INFO - TEST-INFO | started process 7179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCS4rn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:55 INFO - PROCESS | 7179 | RSS: Main: 173514752 13:17:55 INFO - PROCESS | 7179 | 13:18:46 INFO - PROCESS | 7179 | 1465762726253 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] 13:20:55 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48509/tests/dromaeo/cssquery-ext.html) 13:20:56 INFO - PROCESS | 7179 | RSS: Main: 264695808 13:20:56 INFO - PROCESS | 7179 | 13:23:58 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-ext.html (next: http://localhost:48509/tests/dromaeo/cssquery-jquery.html) 13:23:59 INFO - PROCESS | 7179 | RSS: Main: 263380992 13:23:59 INFO - PROCESS | 7179 | 13:27:01 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48509/tests/dromaeo/cssquery-mootools.html) 13:27:01 INFO - PROCESS | 7179 | RSS: Main: 269045760 13:27:01 INFO - PROCESS | 7179 | 13:30:03 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48509/tests/dromaeo/cssquery-prototype.html) 13:30:04 INFO - PROCESS | 7179 | RSS: Main: 266055680 13:30:04 INFO - PROCESS | 7179 | 13:33:07 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48509/tests/dromaeo/cssquery-yui.html) 13:33:07 INFO - PROCESS | 7179 | RSS: Main: 231993344 13:33:07 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | Cycle 1(1): loaded http://localhost:48509/tests/dromaeo/cssquery-yui.html (next: http://localhost:48509/tests/dromaeo/cssquery-dojo.html) 13:36:10 INFO - PROCESS | 7179 | RSS: Main: 296034304 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | __start_tp_report 13:36:10 INFO - PROCESS | 7179 | _x_x_mozilla_page_load 13:36:10 INFO - PROCESS | 7179 | _x_x_mozilla_page_load_details 13:36:10 INFO - PROCESS | 7179 | |i|pagename|runs| 13:36:10 INFO - PROCESS | 7179 | |0;dojo.html;3090.7836451448393;3101.922451938701;3128.1710346758105;3165.841707914604;3167.8099314041146;5381.381141168767;5393.892122157559;5436.456354364562;5486.177073438981;5546.778128874846;5370.087085195516;5406.107992181295;5426.538744206747;5441.700706461143;5492.47821456961;4912.3368345273375;4990.6257030722845;4998.77505512251;5023.095842748304;5117.795288188468;5023.14606516893;5056.747162641872;5070.645054846163;5090.287359769635;5093.821716239932;4823.131836269453;4832.251001094836;4905.754712264408;4907.9263811042865;5025.472325405834;4792.688475249098;4803.9911618560145;4804.903901921942;4805.75971201442;4921.089598424303;4832.806687732486;4855.4901735317635;4872.123017856784;4881.487443818383;4924.4090709115135;5331.946680533184;5379.515843574058;5388.676679399248;5421.756020979065;5431.777849983761;5850.06398976166;5852.12218167274;5902.026165682657;5914.822555323347;5915.467607915309;5946.791862284843;5955.6128851624935;5961.612495187799;5962.34414214436;5975.492083172936;5355.3841308249275;5386.865328366822;5424.105022671254;5426.616212865773;5476.644018138808;5964.373740757158;5965.463108320272;5967.701614919237;5974.3428222895445;5975.492083172979;5509.779608815603;5740.253767010262;5741.511971482387;5744.569157313218;5745.368009518949;5775.711214439261;5813.476787089182;5827;5860.033094539439;5869.882602347929;5821.417858214145;5821.912671309934;5839;5840.795572154954;5850.23946886902;5632.493075623213;5655.208270842086;5795.768169273266;5855.473007429352;5863.3257175424515;4364.912701745948;4374.343848422762;4375.562443755663;4413.051193993307;4417.491988421372;3892.2020985697864;3906.1797022625565;3910.7458015228917;3928.155446578999;3947.50656167979;5340.225667278223;5385.7576409061685;5437.755301011464;5442.863928401822;5457.781688732406;5766.625169363978;5828.854278643068;5854.531637468992;5854.619449735754;5897.49871260939;5501.587380946445;5519.089350257163;5526.668399896019;5528.9723551381985;5533.335999680065;4934.55588996992;4947;4957.3059771632;5033.697978121324;5093.490650934951;5952.642841429528;5956.4341387568975;5958.851028724316;5961.523078153824;6000.249968753906;5813.883722325614;5822.301323841166;5824.271966004249;5828.562857785599;5834.562407819346;5834.358220595816;5896.70516474166;5953.404659534012;5965.985782417087;5974.880502389841;5704.543636509153;5749.8562535936935;5751.568632352674;5759.424057594375;5762.8847423050465;5858.7070646468355;5867.149263356875;5867.5305975521005;5868;5873.706314684334;5401.054815407209;5536.833894983157;5552.750126244248;5570.359408668055;5614.29821272341;5597.888042239051;5602.775888964396;5606.747696353592;5609.775608975595;5611.410801865909;5461.453854614507;5527.778888844401;5555.22226888244;5556.603118208047;5560.582956278215;5558.666480011212;5561.165825126263;5597.048501754793;5677.971610141923;5689.203511508309;5478.863028424162;5484.369297530676;5486.231927530229;5489.862753431196;5492.395836458067 13:36:10 INFO - PROCESS | 7179 | |1;ext.html;593.8248216776053;629.7764293675742;634.8793729191453;643.1510406263734;650.6779144323559;32393.51409728853;34921.82539087304;34967.475487867705;34994.650053499456;43033.569664303424;41337.793311033405;45012.549874501245;45047.77476112615;45075.54924450754;45127;8898.66520021997;9063.048379920112;9064.27778722044;9066.682666106688;9067.909320906772;8928.330375221853;9044.412113212653;9049.909500904972;9050.77373065672;9051.683191088314;9050.683226087089;9102.817943641123;9103.63585456581;9110.863337049916;9113.40762850416;8996.145366190234;9039.231665308456;9053.50205738684;9055.95472022639;9059.094090590954;8915.28677705782;8981.326400519987;8987.505687187202;8990.37067405282;8990.685326013623;42784.57215427868;43088.78455607702;43147.35278970818;43157;43182.784086079686;3625.728070394731;3732.64539868712;3743.0455233915177;3756.398976163801;3988.2422339755353;32309.83845080783;32942.67057329444;33051.33897322064;34015.31969360599;34316.48525272123;4293.699441039129;4340.110277393158;4372.825086996516;4388.561143885618;4401.295792673157;346900;347216;347366.2631686851;348453;349969;56060.439395606336;56316.43683563112;56673.43326566764;56707.716461418255;56709.7164514183;36580;37624.247515049545;60613.393866061655;60679.393206067376;60685.08972365418;17807.46577602674;17903.46289611314;17972.19125139346;17974.820251797315;17975.640487190183;13735.45058197681;13834.723305533833;13840.4463821446;13841.446342146402;13849.030567860153;19860.304889328803;19912.70130948037;19997.700034499496;20084.89957550203;20095.799042009392;6970.651467426608;7066.827170422026;7135.750248741373;7147.642617869085;7201.279872012861;965;1053.0973891339088;1059.4014381874217;1109.2124591539934;1117.6144230240554;32108.357832843212;32169.195770105467;32276.677233227838;32323.51514727281;32685.18287042843;1019.2610357490908;1101.262154356567;1114.816055350858;1138.3795831271977;1160.7620437810397;16328.591785205228;16638.916805415894;16640.50078497647;16647.916760416363;16685.165741712866;566137;570471;571753;571982;572365;58541.70729146327;60028.69985650131;60155;60158.69920650369;60161.699191503765;1231.5689508672071;1281.5642681488152;1286.3696788573532;1370.2189751841354;1376.1330361872156;25169.622455663546;31635.84182079075;32159;32636.347273054882;32821.835890820395;57998;58039.70980145072;58757.70621146867;58798.412015879294;58814.705926470095;489323;495683;495737;496379;496588;32512.187195320304;44731.776341118086;45343.54656453525;46642;47183.528164717914;47992;48680.5131948676;48733;48829;49152.26271606;38502.22995540129;40538.59461405348;40647.18705625812;40735.59264407318;41204.38193427041;39384.2123157541;40140.46434576482;40240;40301.39547906725;40966.590334096276;31956.36087278288;40489.79755101206;40947.795261024694;40965.38551921783;41074.38388424236;36354.4546831803;37424.00607951303;37636.435453467675;37847.43228851514;38531.2293754129;27510.724892750815;27525.862370688017;27705.584416234175;27921.301967450978;27973.86013070003 13:36:10 INFO - PROCESS | 7179 | |2;jquery.html;410.98972525686855;413.6091393633017;414.22953306849234;420.17645414986623;431.9740815551067;13651;17882.91058544707;19377.806221937775;19378.12798424071;20434.69347959778;17866.10669466528;18671.626567468644;18698.53253668659;19279.903600482012;19621.607567848634;5379.408265090837;5533.806316778913;5539.25220095286;5540.50135487806;5564.554835613141;4083.938740918874;5534.889302213954;5551.278333816618;5554.2779438672915;5578.609497335188;5838.386969368219;6125.72434240458;6131.202943617323;6260.843478913018;6261.467775239087;5976.64140151588;6123.142760013579;6185.536084793636;6229.065640154013;6251.656158911258;5936.584439089265;5936.7922122725495;5943.762249510014;5961.850953726148;5965.403459654;14859.257037148207;14962.925185374004;15304.770428443582;15323;15365.923170384189;2361.1381845626393;2407.265783935899;2423.3578101803037;2748.367875388672;2967.95548066777;10728.570857165703;11211.71970700739;11306.321620702784;12746.362681865963;14979;1957.765068191826;1967.4982879365814;1993.4816947593586;2018.3238615063972;2036.4908772806798;85341.57329213314;86998.56500717519;89139.55430222872;89592;90982.99999999935;11429.942850285695;11452.828207576893;11620.825687614693;11776.17566770335;11869.881301186877;16356.263968121226;16468.505944821674;16599.170041498117;16667.583310417092;16715.247813848408;8608.440451370641;8826.382153249338;8875.378723489423;8889.333300002396;8965.506897120591;8446.535440550828;8557.058723540405;8652.3510736695;8693.174148455886;8803.603837827313;4938.4320803107385;5000.574951129122;5052.267421223975;5103;5201.063808514504;1984.1269841270084;2027.513396784761;2031.7155598216261;2060.546679730457;2107.2519255664324;862.4652715316544;907.981840363189;959.4770849886689;960.3469640644289;1008.8738907636546;18145.7278140828;19561.706574401396;19566.608667826564;19622;20094.196232150844;990.8166989107038;1008.8991100889853;1025.9538320775582;1031.8142734307746;1063.3088492479949;10580.735481613021;11298.491567879466;11310.151738619636;11369.147313951487;11392;483519;488867;490235;490981;494366;74553;96647;101416;103043.48478257711;104985;972.1056627902346;981.0728861226073;1066.642674703983;1088.1458055426451;1101.8512500812449;17512.299508019536;17586.472405827335;17905.910470447565;18109.366172184436;18359;44401.33397998968;44486.55513444953;44609;44667.55332446634;44890.77554612206;53731.19403209033;54336.728316359746;62116.37883621287;64101;64170;9295.442273463614;9386.530673466435;9544.188743956563;9552.904470955202;9634.71095867125;13926.721465570834;14124.50564230247;14284;14302.928485357506;14831.777523336943;11970.162088653711;12012.63962081139;12199.817002744789;12278.386080696107;12311.938440307742;12138.33239171854;12178.147529672839;12314.445849936954;12321.568745093879;12389.380530973596;12263.202891812003;12280.938595306967;12294.508219671114;12295.200811947196;12738.172018818746;9410.81178376415;9451.716448506555;9486.28852836054;9555.808883822423;9712.70861874145;9954;12528.436220369922;12573.434195461408;12618.116731828684;12625.368731563201 13:36:10 INFO - PROCESS | 7179 | |3;mootools.html;1301.5509649171033;1429.076477998695;1455.3087283540317;1568.803899512561;1714.091531488311;8814.427062240959;9166.450012999216;9197.172254497094;9412.482313472756;9429.717108486739;9068.274538036958;9235.076492350761;9277.489738064403;9302.86045709315;9308.674196403128;2155.0948601587293;2347.3544775186874;2418.6251131074623;2445.816563757721;2490.066225165563;2486.676732024834;2493.9127130550432;2497.2008957133635;2498.088197807796;2498.57524220882;2408.7109546854313;2468.111479867255;2468.5309791139716;2469.172827102923;2472.0359059966627;2084.395525297662;2298.6666933294578;2361.2916125162556;2365.302235840423;2375.2280508834697;2408.5664580375524;2441.9145329913367;2446.54738873309;2465.963010554843;2468.7037555493275;9513.619455221851;9525.047495250488;9576.329656924017;9584.520773961343;9589.18491928187;5512.972435137839;5650.350209725893;5655.5475561954945;5656.660600363992;5662.094064949588;3501.7215985017733;3536.929261414783;3609.4946707460977;3649.817509124533;3702.2780557791243;1211.485118824505;1216.6714986953561;1237.3503910446998;1263.2357423758585;1266.2529107826426;13399.330033498383;13474.595762127054;13475.528356507573;13484.460621575125;13485.460581576725;5058.494150584986;5059.215821547666;5060.063888180698;5060.620453466005;5151.665141765773;11148.052415544607;11236.381998990135;11242.55029798799;11243.831342529706;11263.718407039889;5605.80379686709;5607.49532542065;5612.579056570774;5613.803516876889;5616.129499927518;4495.325701144789;4931.50684931504;5080.263361812516;5080.59355251579;5167.948320516747;4145.3781932709735;4177.665786737054;4251.744895306291;4268.125034367947;4285.292926667065;1263.1266833040834;1283.8972882169403;1286.7040580666498;1287.1697754948007;1300.109425043829;993.1607791416242;995.1640621877658;1003.1773945364877;1019.7603563162651;1038.693585392311;6259.593126446766;6345;6480.643564603898;6606.966965165239;6646.003099535108;479.4270846338662;487.19369443570946;492.45829587453517;496.3299545613393;496.3919198981219;4497.527759585262;4499.212637788374;4521.660875434355;4551.385562949025;4577.679562430664;11351.432428378714;11708.356040417688;11764.294142351315;11770.52917883275;11782.823257651142;11242.807652507683;11452.083833293316;11640.94179529097;11699.2980421175;11969.700757481132;8633.95683021581;8744.213020828156;8754;8796.604152813139;8806.207441330183;6277.780277690259;6588.637624930675;6719.932800671931;6727.394534491919;6800.353966373186;10354.17166626653;10729.517171727448;11050.889491104987;11145.777084458428;11224.494897729459;10971.561137554409;11207.887921121011;11260;11352.262102963281;11367.033802126582;7438.256174382518;7607.049118860143;7613.847723045619;8403.243708066304;8576.056633770406;8652.524111173945;8923.955380223057;9223;9224.538773061455;9507.191888689538;8086.757397278091;8212.671493140208;8333.874991875005;8344.457610255315;8398.832023359377;8006.1993800619475;8150.184981501802;8273.586320683822;8279.296259817984;8282;7351.8529629408185;7379.631018449163;7696.615169241628;7705.691772329044;7706.730264440717;5498.835034948958;5520.1167813149705;5538.141588053858;5544.889102218014;5815.447532484407;5571.749271282721;5583.720813959367;5693.686847223443;5742.913856292075;5772.769089236552 13:36:10 INFO - PROCESS | 7179 | |4;prototype.html;347.5429809800113;348.51730353460465;358.24053007623843;360.1302853608536;361.41811683190076;5341.706206158659;5424.566034717223;5440.265564148839;5441;5445.782168713246;5324.813631522898;5330.387005494369;5344.893102137955;5357.517823395893;5369;3985.2826491231567;4240.257954857888;4250.2137104635585;4261.764088414356;4290.141971605676;4168.687348448863;4214.388913607525;4245;4249.490061192646;4261.659067274626;4000.83975647062;4089.7546147231114;4186.874393768192;4201.306784380574;4201.642860356873;4155.750654960712;4156.542780294165;4157.085441202946;4164.66682665386;4167.2082304362075;3683.465897444882;3699.907502312437;3707.5736290326417;3712.5706602958057;3728.5525736911472;4985.476524964899;5031.371078615173;5168.767405466763;5237.738113094369;5273.551748101416;4732.574068333832;4738.857834264943;4758;4766.856994290177;4786.808527658889;5476.507114359687;5524.088525393306;5533.861653458655;5590.748416321276;5666.773329066832;3884.1454879926373;4036.1120553478186;4082.183563287325;4082.9387559186634;4105.158442519277;5816.680082595455;5819.817568411846;5840.795572154997;5844.1818145459665;5859.736311865976;4153.501579810442;4159.334506478949;4159.729617574848;4159.771212583337;4182.142660754538;4149.647279981175;4215.683823713233;4217.704760666724;4244.702870799015;4252.638525725286;4765.1660959331975;4780.737059461763;4783.397561816831;4827.348307978378;4829.082474329866;5665.6034077614995;5684.34630017545;5730;5745.195672605839;5747.1379293106365;1430.9212993285262;1447.6887469194173;1452.192020933944;1452.4988878836784;1457.9343929523197;924.1682485762867;935.3779736475303;939.0656296984407;947.6114792934864;950.273041123541;4823.601155664888;4877.341558889575;4890.437599676012;4895.559399654048;4907.779149938261;5119.513646203604;5127.666806630228;5155.175171972466;5201.635885487979;5214.843554693365;4913.729744864067;5211;5305.65513241638;5423.511883930386;5459.071957767189;3038.468268053082;3049.1767222849708;3079.2609773654162;3082.027502398467;3092.737117345051;5764.510016648632;5921.911171332347;5969.194158788595;5972.313183983897;5972.462478376967;5938.584299099021;5946.940530594725;5971.611845230046;5972.790952316648;5980.312264089685;5821.224526519283;5979.9402005980255;6011.489023433057;6020.217371741734;6047.909281360695;5650.802221922213;5769.826905192851;5773.53811695055;5796.362400135898;5811.128330750421;5590.468905453975;5668.773249069991;5711.257536520226;5760.164776107525;5766.693322670965;5637.154426836008;5855.8536036597725;5904.675242861512;5927.496162826208;5962.284525856751;4260.339647354665;4298.441202643637;4299.914001719885;4310.806013729452;4311.913761724811;5814.709264536672;5815.360310365941;5823.272090988627;5824.815694114707;5838.1826544282985;5551.444855514416;5567.610267281251;5581.274434323512;5603.80386686464;5713.771449141987;5528.281323427928;5536.501714845684;5549.1676248563035;5584.525315348241;5598.664080155204;5448.618596698193;5449.555867695143;5476.780928762805;5514.393416724238;5530.834074977757;5339.786408543615;5625.8593535161945;5630.718464076698;5632.577556683347;5648.971755141198;5288.4182739897815;5477.972610136924;5485.232067510631;5486.643368181056;5519.172124181405 13:36:10 INFO - PROCESS | 7179 | |5;yui.html;719.0400814912092;744.2483092077003;765.7855800375889;800.8358286551256;858.4205661178706;14432.711345773092;14452.205128717917;14573.05275157114;14602.780958285633;14621.561353159408;14787.556373308818;14853.331600077996;14878.925605371958;14902.031367961075;14926.850731492681;642.0433554004522;763.0652450747831;777.9299863012328;779.9064112306503;779.9337056350189;758.7420277105783;769.4921351907742;773.6711897443593;776.8834674798769;783.725696006399;823.4153750836913;831.787894087007;834.6369329341726;835.5488036460304;835.9832803343929;675.7432175773224;803.04036676172;831.4221615976899;831.5343407691681;831.9126491718373;603.1254680712984;605.1165298663956;606.754264522869;607.0378450156508;607.2864384348374;15590.142542160176;15604.063756174666;15613.843861561467;15649.765253521093;15666;14088.506902258474;14411.92794036023;14424.423023079169;14427.855721442756;14830.555083347517;12876.484940602364;12914.741705165938;13120.212787232796;13128.6717832054;13261.801072983913;4399.560043995607;4453.153900758845;4488.5960263576435;4648.070385922829;4687.086018226447;80551.597242014;82132.17867821305;82262;82857;84073.57963210145;11489.42552872353;11658.708532286591;11658.70853228676;11778.823317650242;11982.10134239918;22408.66387004196;22446.77553224447;22504.662430063563;22509.43726406853;22547.43631409228;8098.878516822252;8170.182981701782;8216.178382161735;8346.332293416634;8426.031006434216;4363.825446982085;4526.91497467619;4527.683062185682;4528.43394575678;4660.580547750718;3548.822558872046;3639.636036396339;3657.9268414632093;3663.395539735967;3668.0829792551863;608.3672980100646;610.5542953643865;612.1949636228435;612.295859761278;612.3753771153398;533.6264614769676;608.333874407523;713.293839099288;758.2569082299377;758.9022206570182;9583.939453017634;9874.358166719141;10004.599816007278;10118.59525618967;10216.284860059724;702.8102412348637;741.3698356397019;752.860720766649;753.1978442958232;754.0410962292941;4282.164977829293;4618.1918164321105;4680.976595117071;4978.502149785065;5252.632315737938;124267;128353.35823320823;129425;130273;130758;80272;80426.59786701029;80810;94664;95780;84485;86288.56855715682;87666.56166719254;88566.55716721374;89174;10121.342112762646;10154.492275386054;10207.336523125972;10262.384256944608;10277.280590358603;50300.49699502958;50445.49554504408;50720.74639626778;50928;51547.22679159741;50910.74544627401;51006.48993510017;57685;72232.27767722255;74780;12884.291363975071;12985.415656295678;13195.274259915797;13405.320642923534;14035.228062456663;13980.790288145889;14742.557723268319;14823.481178158712;14951.476698315506;14955.551333460013;14024.29878506091;14145.222012789396;14306.213158276394;15206.543803685907;15227.619309517351;12829.10196286251;13690.589282321545;13815;13842.169469831842;14073.155610663393;13513.594592162252;13675.658108547366;14124.646883827987;14247.928760356132;14554.781678274623;11633.360165190996;11924;12045.277283363026;12197.207181533173;12241.693957650774;11605.593804216813;12039.277643341427;12075.652286617169;12353.62939111828;12422.440990155284 13:36:10 INFO - PROCESS | 7179 | __end_tp_report 13:36:10 INFO - PROCESS | 7179 | __start_cc_report 13:36:10 INFO - PROCESS | 7179 | _x_x_mozilla_cycle_collect,773 13:36:10 INFO - PROCESS | 7179 | __end_cc_report 13:36:10 INFO - PROCESS | 7179 | __startTimestamp1465763770772__endTimestamp 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | ------- Summary: start ------- 13:36:10 INFO - PROCESS | 7179 | Number of tests: 6 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#0] dojo.html Cycles:165 Average:5381.87 Median:5533.34 stddev:620.73 (11.2%) stddev-sans-first:596.04 13:36:10 INFO - PROCESS | 7179 | Values: 3090.8 3101.9 3128.2 3165.8 3167.8 5381.4 5393.9 5436.5 5486.2 5546.8 5370.1 5406.1 5426.5 5441.7 5492.5 4912.3 4990.6 4998.8 5023.1 5117.8 5023.1 5056.7 5070.6 5090.3 5093.8 4823.1 4832.3 4905.8 4907.9 5025.5 4792.7 4804.0 4804.9 4805.8 4921.1 4832.8 4855.5 4872.1 4881.5 4924.4 5331.9 5379.5 5388.7 5421.8 5431.8 5850.1 5852.1 5902.0 5914.8 5915.5 5946.8 5955.6 5961.6 5962.3 5975.5 5355.4 5386.9 5424.1 5426.6 5476.6 5964.4 5965.5 5967.7 5974.3 5975.5 5509.8 5740.3 5741.5 5744.6 5745.4 5775.7 5813.5 5827.0 5860.0 5869.9 5821.4 5821.9 5839.0 5840.8 5850.2 5632.5 5655.2 5795.8 5855.5 5863.3 4364.9 4374.3 4375.6 4413.1 4417.5 3892.2 3906.2 3910.7 3928.2 3947.5 5340.2 5385.8 5437.8 5442.9 5457.8 5766.6 5828.9 5854.5 5854.6 5897.5 5501.6 5519.1 5526.7 5529.0 5533.3 4934.6 4947.0 4957.3 5033.7 5093.5 5952.6 5956.4 5958.9 5961.5 6000.2 5813.9 5822.3 5824.3 5828.6 5834.6 5834.4 5896.7 5953.4 5966.0 5974.9 5704.5 5749.9 5751.6 5759.4 5762.9 5858.7 5867.1 5867.5 5868.0 5873.7 5401.1 5536.8 5552.8 5570.4 5614.3 5597.9 5602.8 5606.7 5609.8 5611.4 5461.5 5527.8 5555.2 5556.6 5560.6 5558.7 5561.2 5597.0 5678.0 5689.2 5478.9 5484.4 5486.2 5489.9 5492.4 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#1] ext.html Cycles:180 Average:63026.72 Median:41271.09 stddev:127558.52 (309.1%) stddev-sans-first:127830.23 13:36:10 INFO - PROCESS | 7179 | Values: 593.8 629.8 634.9 643.2 650.7 32393.5 34921.8 34967.5 34994.7 43033.6 41337.8 45012.5 45047.8 45075.5 45127.0 8898.7 9063.0 9064.3 9066.7 9067.9 8928.3 9044.4 9049.9 9050.8 9051.7 9050.7 9102.8 9103.6 9110.9 9113.4 8996.1 9039.2 9053.5 9056.0 9059.1 8915.3 8981.3 8987.5 8990.4 8990.7 42784.6 43088.8 43147.4 43157.0 43182.8 3625.7 3732.6 3743.0 3756.4 3988.2 32309.8 32942.7 33051.3 34015.3 34316.5 4293.7 4340.1 4372.8 4388.6 4401.3 346900.0 347216.0 347366.3 348453.0 349969.0 56060.4 56316.4 56673.4 56707.7 56709.7 36580.0 37624.2 60613.4 60679.4 60685.1 17807.5 17903.5 17972.2 17974.8 17975.6 13735.5 13834.7 13840.4 13841.4 13849.0 19860.3 19912.7 19997.7 20084.9 20095.8 6970.7 7066.8 7135.8 7147.6 7201.3 965.0 1053.1 1059.4 1109.2 1117.6 32108.4 32169.2 32276.7 32323.5 32685.2 1019.3 1101.3 1114.8 1138.4 1160.8 16328.6 16638.9 16640.5 16647.9 16685.2 566137.0 570471.0 571753.0 571982.0 572365.0 58541.7 60028.7 60155.0 60158.7 60161.7 1231.6 1281.6 1286.4 1370.2 1376.1 25169.6 31635.8 32159.0 32636.3 32821.8 57998.0 58039.7 58757.7 58798.4 58814.7 489323.0 495683.0 495737.0 496379.0 496588.0 32512.2 44731.8 45343.5 46642.0 47183.5 47992.0 48680.5 48733.0 48829.0 49152.3 38502.2 40538.6 40647.2 40735.6 41204.4 39384.2 40140.5 40240.0 40301.4 40966.6 31956.4 40489.8 40947.8 40965.4 41074.4 36354.5 37424.0 37636.4 37847.4 38531.2 27510.7 27525.9 27705.6 27921.3 27973.9 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#2] jquery.html Cycles:180 Average:29532.23 Median:2384.20 stddev:80973.22 (3396.2%) stddev-sans-first:81170.84 13:36:10 INFO - PROCESS | 7179 | Values: 411.0 413.6 414.2 420.2 432.0 13651.0 17882.9 19377.8 19378.1 20434.7 17866.1 18671.6 18698.5 19279.9 19621.6 5379.4 5533.8 5539.3 5540.5 5564.6 4083.9 5534.9 5551.3 5554.3 5578.6 5838.4 6125.7 6131.2 6260.8 6261.5 5976.6 6123.1 6185.5 6229.1 6251.7 5936.6 5936.8 5943.8 5961.9 5965.4 14859.3 14962.9 15304.8 15323.0 15365.9 2361.1 2407.3 2423.4 2748.4 2968.0 10728.6 11211.7 11306.3 12746.4 14979.0 1957.8 1967.5 1993.5 2018.3 2036.5 85341.6 86998.6 89139.6 89592.0 90983.0 11429.9 11452.8 11620.8 11776.2 11869.9 16356.3 16468.5 16599.2 16667.6 16715.2 8608.4 8826.4 8875.4 8889.3 8965.5 8446.5 8557.1 8652.4 8693.2 8803.6 4938.4 5000.6 5052.3 5103.0 5201.1 1984.1 2027.5 2031.7 2060.5 2107.3 862.5 908.0 959.5 960.3 1008.9 18145.7 19561.7 19566.6 19622.0 20094.2 990.8 1008.9 1026.0 1031.8 1063.3 10580.7 11298.5 11310.2 11369.1 11392.0 483519.0 488867.0 490235.0 490981.0 494366.0 74553.0 96647.0 101416.0 103043.5 104985.0 972.1 981.1 1066.6 1088.1 1101.9 17512.3 17586.5 17905.9 18109.4 18359.0 44401.3 44486.6 44609.0 44667.6 44890.8 53731.2 54336.7 62116.4 64101.0 64170.0 9295.4 9386.5 9544.2 9552.9 9634.7 13926.7 14124.5 14284.0 14302.9 14831.8 11970.2 12012.6 12199.8 12278.4 12311.9 12138.3 12178.1 12314.4 12321.6 12389.4 12263.2 12280.9 12294.5 12295.2 12738.2 9410.8 9451.7 9486.3 9555.8 9712.7 9954.0 12528.4 12573.4 12618.1 12625.4 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#3] mootools.html Cycles:180 Average:6207.69 Median:489.83 stddev:3596.53 (734.2%) stddev-sans-first:3587.72 13:36:10 INFO - PROCESS | 7179 | Values: 1301.6 1429.1 1455.3 1568.8 1714.1 8814.4 9166.5 9197.2 9412.5 9429.7 9068.3 9235.1 9277.5 9302.9 9308.7 2155.1 2347.4 2418.6 2445.8 2490.1 2486.7 2493.9 2497.2 2498.1 2498.6 2408.7 2468.1 2468.5 2469.2 2472.0 2084.4 2298.7 2361.3 2365.3 2375.2 2408.6 2441.9 2446.5 2466.0 2468.7 9513.6 9525.0 9576.3 9584.5 9589.2 5513.0 5650.4 5655.5 5656.7 5662.1 3501.7 3536.9 3609.5 3649.8 3702.3 1211.5 1216.7 1237.4 1263.2 1266.3 13399.3 13474.6 13475.5 13484.5 13485.5 5058.5 5059.2 5060.1 5060.6 5151.7 11148.1 11236.4 11242.6 11243.8 11263.7 5605.8 5607.5 5612.6 5613.8 5616.1 4495.3 4931.5 5080.3 5080.6 5167.9 4145.4 4177.7 4251.7 4268.1 4285.3 1263.1 1283.9 1286.7 1287.2 1300.1 993.2 995.2 1003.2 1019.8 1038.7 6259.6 6345.0 6480.6 6607.0 6646.0 479.4 487.2 492.5 496.3 496.4 4497.5 4499.2 4521.7 4551.4 4577.7 11351.4 11708.4 11764.3 11770.5 11782.8 11242.8 11452.1 11640.9 11699.3 11969.7 8634.0 8744.2 8754.0 8796.6 8806.2 6277.8 6588.6 6719.9 6727.4 6800.4 10354.2 10729.5 11050.9 11145.8 11224.5 10971.6 11207.9 11260.0 11352.3 11367.0 7438.3 7607.0 7613.8 8403.2 8576.1 8652.5 8924.0 9223.0 9224.5 9507.2 8086.8 8212.7 8333.9 8344.5 8398.8 8006.2 8150.2 8273.6 8279.3 8282.0 7351.9 7379.6 7696.6 7705.7 7706.7 5498.8 5520.1 5538.1 5544.9 5815.4 5571.7 5583.7 5693.7 5742.9 5772.8 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#4] prototype.html Cycles:180 Average:4708.47 Median:5335.09 stddev:1370.96 (25.7%) stddev-sans-first:1335.16 13:36:10 INFO - PROCESS | 7179 | Values: 347.5 348.5 358.2 360.1 361.4 5341.7 5424.6 5440.3 5441.0 5445.8 5324.8 5330.4 5344.9 5357.5 5369.0 3985.3 4240.3 4250.2 4261.8 4290.1 4168.7 4214.4 4245.0 4249.5 4261.7 4000.8 4089.8 4186.9 4201.3 4201.6 4155.8 4156.5 4157.1 4164.7 4167.2 3683.5 3699.9 3707.6 3712.6 3728.6 4985.5 5031.4 5168.8 5237.7 5273.6 4732.6 4738.9 4758.0 4766.9 4786.8 5476.5 5524.1 5533.9 5590.7 5666.8 3884.1 4036.1 4082.2 4082.9 4105.2 5816.7 5819.8 5840.8 5844.2 5859.7 4153.5 4159.3 4159.7 4159.8 4182.1 4149.6 4215.7 4217.7 4244.7 4252.6 4765.2 4780.7 4783.4 4827.3 4829.1 5665.6 5684.3 5730.0 5745.2 5747.1 1430.9 1447.7 1452.2 1452.5 1457.9 924.2 935.4 939.1 947.6 950.3 4823.6 4877.3 4890.4 4895.6 4907.8 5119.5 5127.7 5155.2 5201.6 5214.8 4913.7 5211.0 5305.7 5423.5 5459.1 3038.5 3049.2 3079.3 3082.0 3092.7 5764.5 5921.9 5969.2 5972.3 5972.5 5938.6 5946.9 5971.6 5972.8 5980.3 5821.2 5979.9 6011.5 6020.2 6047.9 5650.8 5769.8 5773.5 5796.4 5811.1 5590.5 5668.8 5711.3 5760.2 5766.7 5637.2 5855.9 5904.7 5927.5 5962.3 4260.3 4298.4 4299.9 4310.8 4311.9 5814.7 5815.4 5823.3 5824.8 5838.2 5551.4 5567.6 5581.3 5603.8 5713.8 5528.3 5536.5 5549.2 5584.5 5598.7 5448.6 5449.6 5476.8 5514.4 5530.8 5339.8 5625.9 5630.7 5632.6 5649.0 5288.4 5478.0 5485.2 5486.6 5519.2 13:36:10 INFO - PROCESS | 7179 | 13:36:10 INFO - PROCESS | 7179 | [#5] yui.html Cycles:180 Average:20839.91 Median:4426.36 stddev:30178.87 (681.8%) stddev-sans-first:30225.71 13:36:10 INFO - PROCESS | 7179 | Values: 719.0 744.2 765.8 800.8 858.4 14432.7 14452.2 14573.1 14602.8 14621.6 14787.6 14853.3 14878.9 14902.0 14926.9 642.0 763.1 777.9 779.9 779.9 758.7 769.5 773.7 776.9 783.7 823.4 831.8 834.6 835.5 836.0 675.7 803.0 831.4 831.5 831.9 603.1 605.1 606.8 607.0 607.3 15590.1 15604.1 15613.8 15649.8 15666.0 14088.5 14411.9 14424.4 14427.9 14830.6 12876.5 12914.7 13120.2 13128.7 13261.8 4399.6 4453.2 4488.6 4648.1 4687.1 80551.6 82132.2 82262.0 82857.0 84073.6 11489.4 11658.7 11658.7 11778.8 11982.1 22408.7 22446.8 22504.7 22509.4 22547.4 8098.9 8170.2 8216.2 8346.3 8426.0 4363.8 4526.9 4527.7 4528.4 4660.6 3548.8 3639.6 3657.9 3663.4 3668.1 608.4 610.6 612.2 612.3 612.4 533.6 608.3 713.3 758.3 758.9 9583.9 9874.4 10004.6 10118.6 10216.3 702.8 741.4 752.9 753.2 754.0 4282.2 4618.2 4681.0 4978.5 5252.6 124267.0 128353.4 129425.0 130273.0 130758.0 80272.0 80426.6 80810.0 94664.0 95780.0 84485.0 86288.6 87666.6 88566.6 89174.0 10121.3 10154.5 10207.3 10262.4 10277.3 50300.5 50445.5 50720.7 50928.0 51547.2 50910.7 51006.5 57685.0 72232.3 74780.0 12884.3 12985.4 13195.3 13405.3 14035.2 13980.8 14742.6 14823.5 14951.5 14955.6 14024.3 14145.2 14306.2 15206.5 15227.6 12829.1 13690.6 13815.0 13842.2 14073.2 13513.6 13675.7 14124.6 14247.9 14554.8 11633.4 11924.0 12045.3 12197.2 12241.7 11605.6 12039.3 12075.7 12353.6 12422.4 13:36:10 INFO - PROCESS | 7179 | -------- Summary: end -------- 13:36:10 INFO - PROCESS | 7179 | 13:36:11 INFO - TEST-INFO | 7179: exit 0 13:36:11 INFO - TEST-OK | dromaeo_css | took 1114194ms 13:36:11 INFO - TEST-START | kraken 13:36:11 INFO - operating with platform_type : linux_ 13:36:11 INFO - Initialising browser for kraken test... 13:36:11 INFO - TEST-INFO | started process 7365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnS9Xx/profile http://localhost:48509/getInfo.html) 13:36:15 INFO - PROCESS | 7365 | __metrics Screen width/height:1600/1200 13:36:15 INFO - PROCESS | 7365 | colorDepth:24 13:36:15 INFO - PROCESS | 7365 | Browser inner width/height: 1024/697 13:36:15 INFO - PROCESS | 7365 | __metrics 13:36:16 INFO - PROCESS | 7365 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:16 INFO - PROCESS | 7365 | console.error: PushService: 13:36:16 INFO - PROCESS | 7365 | stateChangeProcessEnqueue: Error transitioning state 13:36:16 INFO - PROCESS | 7365 | UnknownError 13:36:17 INFO - TEST-INFO | 7365: exit 0 13:36:17 INFO - Browser initialized. 13:36:17 INFO - Running cycle 1/1 for kraken test... 13:36:17 INFO - TEST-INFO | started process 7445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnS9Xx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:29 INFO - PROCESS | 7445 | RSS: Main: 173797376 13:36:29 INFO - PROCESS | 7445 | 13:36:31 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48509/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:32 INFO - PROCESS | 7445 | RSS: Main: 233263104 13:36:32 INFO - PROCESS | 7445 | 13:36:35 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48509/tests/kraken/driver.html?testName=audio-dft) 13:36:36 INFO - PROCESS | 7445 | RSS: Main: 217268224 13:36:36 INFO - PROCESS | 7445 | 13:36:39 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48509/tests/kraken/driver.html?testName=audio-fft) 13:36:39 INFO - PROCESS | 7445 | RSS: Main: 286781440 13:36:39 INFO - PROCESS | 7445 | 13:36:41 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48509/tests/kraken/driver.html?testName=audio-oscillator) 13:36:42 INFO - PROCESS | 7445 | RSS: Main: 197472256 13:36:42 INFO - PROCESS | 7445 | 13:36:44 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:45 INFO - PROCESS | 7445 | RSS: Main: 202285056 13:36:45 INFO - PROCESS | 7445 | 13:36:48 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48509/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:48 INFO - PROCESS | 7445 | RSS: Main: 236580864 13:36:48 INFO - PROCESS | 7445 | 13:36:52 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48509/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:52 INFO - PROCESS | 7445 | RSS: Main: 238899200 13:36:52 INFO - PROCESS | 7445 | 13:36:55 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48509/tests/kraken/driver.html?testName=json-parse-financial) 13:36:56 INFO - PROCESS | 7445 | RSS: Main: 238424064 13:36:56 INFO - PROCESS | 7445 | 13:36:57 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:58 INFO - PROCESS | 7445 | RSS: Main: 226398208 13:36:58 INFO - PROCESS | 7445 | 13:37:00 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:00 INFO - PROCESS | 7445 | RSS: Main: 230998016 13:37:00 INFO - PROCESS | 7445 | 13:37:02 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:03 INFO - PROCESS | 7445 | RSS: Main: 238698496 13:37:03 INFO - PROCESS | 7445 | 13:37:06 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:06 INFO - PROCESS | 7445 | RSS: Main: 240971776 13:37:06 INFO - PROCESS | 7445 | 13:37:09 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:10 INFO - PROCESS | 7445 | RSS: Main: 240107520 13:37:10 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | Cycle 1(1): loaded http://localhost:48509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48509/tests/kraken/driver.html?testName=ai-astar) 13:37:11 INFO - PROCESS | 7445 | RSS: Main: 283217920 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | __start_tp_report 13:37:11 INFO - PROCESS | 7445 | _x_x_mozilla_page_load 13:37:11 INFO - PROCESS | 7445 | _x_x_mozilla_page_load_details 13:37:11 INFO - PROCESS | 7445 | |i|pagename|runs| 13:37:11 INFO - PROCESS | 7445 | |0;ai-astar;110;104;110;110;111;110;109;109;110;109 13:37:11 INFO - PROCESS | 7445 | |1;audio-beat-detection;156;123;138;187;126;126;146;125;172;130 13:37:11 INFO - PROCESS | 7445 | |2;audio-dft;161;160;160;159;159;160;159;159;160;160 13:37:11 INFO - PROCESS | 7445 | |3;audio-fft;74;75;75;116;74;76;75;75;99;75 13:37:11 INFO - PROCESS | 7445 | |4;audio-oscillator;85;85;117;85;84;97;120;84;85;128 13:37:11 INFO - PROCESS | 7445 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;117;117 13:37:11 INFO - PROCESS | 7445 | |6;imaging-darkroom;145;145;146;145;145;145;146;146;146;152 13:37:11 INFO - PROCESS | 7445 | |7;imaging-desaturate;94;95;96;94;95;95;95;95;95;95 13:37:11 INFO - PROCESS | 7445 | |8;json-parse-financial;53;52;53;52;52;53;54;53;51;52 13:37:11 INFO - PROCESS | 7445 | |9;json-stringify-tinderbox;60;60;61;60;61;61;61;61;61;61 13:37:11 INFO - PROCESS | 7445 | |10;stanford-crypto-aes;79;78;79;80;79;80;79;79;118;81 13:37:11 INFO - PROCESS | 7445 | |11;stanford-crypto-ccm;121;139;122;121;128;129;130;127;125;122 13:37:11 INFO - PROCESS | 7445 | |12;stanford-crypto-pbkdf2;167;161;159;165;159;161;163;161;162;160 13:37:11 INFO - PROCESS | 7445 | |13;stanford-crypto-sha256-iterative;69;62;63;63;64;63;63;62;63;65 13:37:11 INFO - PROCESS | 7445 | __end_tp_report 13:37:11 INFO - PROCESS | 7445 | __start_cc_report 13:37:11 INFO - PROCESS | 7445 | _x_x_mozilla_cycle_collect,1620 13:37:11 INFO - PROCESS | 7445 | __end_cc_report 13:37:11 INFO - PROCESS | 7445 | __startTimestamp1465763831917__endTimestamp 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | ------- Summary: start ------- 13:37:11 INFO - PROCESS | 7445 | Number of tests: 14 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.93 (1.8%) stddev-sans-first:2.03 13:37:11 INFO - PROCESS | 7445 | Values: 110.0 104.0 110.0 110.0 111.0 110.0 109.0 109.0 110.0 109.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:142.00 stddev:22.24 (15.7%) stddev-sans-first:23.08 13:37:11 INFO - PROCESS | 7445 | Values: 156.0 123.0 138.0 187.0 126.0 126.0 146.0 125.0 172.0 130.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.53 13:37:11 INFO - PROCESS | 7445 | Values: 161.0 160.0 160.0 159.0 159.0 160.0 159.0 159.0 160.0 160.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.34 (19.1%) stddev-sans-first:14.96 13:37:11 INFO - PROCESS | 7445 | Values: 74.0 75.0 75.0 116.0 74.0 76.0 75.0 75.0 99.0 75.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:17.65 (20.8%) stddev-sans-first:18.18 13:37:11 INFO - PROCESS | 7445 | Values: 85.0 85.0 117.0 85.0 84.0 97.0 120.0 84.0 85.0 128.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 13:37:11 INFO - PROCESS | 7445 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:2.13 (1.5%) stddev-sans-first:2.22 13:37:11 INFO - PROCESS | 7445 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 152.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 13:37:11 INFO - PROCESS | 7445 | Values: 94.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 13:37:11 INFO - PROCESS | 7445 | Values: 53.0 52.0 53.0 52.0 52.0 53.0 54.0 53.0 51.0 52.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:37:11 INFO - PROCESS | 7445 | Values: 60.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:79.00 stddev:12.25 (15.5%) stddev-sans-first:12.90 13:37:11 INFO - PROCESS | 7445 | Values: 79.0 78.0 79.0 80.0 79.0 80.0 79.0 79.0 118.0 81.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:127.50 stddev:5.58 (4.4%) stddev-sans-first:5.57 13:37:11 INFO - PROCESS | 7445 | Values: 121.0 139.0 122.0 121.0 128.0 129.0 130.0 127.0 125.0 122.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:161.50 stddev:2.57 (1.6%) stddev-sans-first:1.92 13:37:11 INFO - PROCESS | 7445 | Values: 167.0 161.0 159.0 165.0 159.0 161.0 163.0 161.0 162.0 160.0 13:37:11 INFO - PROCESS | 7445 | 13:37:11 INFO - PROCESS | 7445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.06 (3.3%) stddev-sans-first:0.93 13:37:11 INFO - PROCESS | 7445 | Values: 69.0 62.0 63.0 63.0 64.0 63.0 63.0 62.0 63.0 65.0 13:37:11 INFO - PROCESS | 7445 | -------- Summary: end -------- 13:37:11 INFO - PROCESS | 7445 | 13:37:12 INFO - TEST-INFO | 7445: exit 0 13:37:12 INFO - TEST-OK | kraken | took 61425ms 13:37:12 INFO - SUITE-END | took 1175s 13:37:13 INFO - Completed test suite (00:19:35) 13:37:13 INFO - javascript benchmark 13:37:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.7836451448393, 3101.922451938701, 3128.1710346758105, 3165.841707914604, 3167.8099314041146, 5381.381141168767, 5393.892122157559, 5436.456354364562, 5486.177073438981, 5546.778128874846, 5370.087085195516, 5406.107992181295, 5426.538744206747, 5441.700706461143, 5492.47821456961, 4912.3368345273375, 4990.6257030722845, 4998.77505512251, 5023.095842748304, 5117.795288188468, 5023.14606516893, 5056.747162641872, 5070.645054846163, 5090.287359769635, 5093.821716239932, 4823.131836269453, 4832.251001094836, 4905.754712264408, 4907.9263811042865, 5025.472325405834, 4792.688475249098, 4803.9911618560145, 4804.903901921942, 4805.75971201442, 4921.089598424303, 4832.806687732486, 4855.4901735317635, 4872.123017856784, 4881.487443818383, 4924.4090709115135, 5331.946680533184, 5379.515843574058, 5388.676679399248, 5421.756020979065, 5431.777849983761, 5850.06398976166, 5852.12218167274, 5902.026165682657, 5914.822555323347, 5915.467607915309, 5946.791862284843, 5955.6128851624935, 5961.612495187799, 5962.34414214436, 5975.492083172936, 5355.3841308249275, 5386.865328366822, 5424.105022671254, 5426.616212865773, 5476.644018138808, 5964.373740757158, 5965.463108320272, 5967.701614919237, 5974.3428222895445, 5975.492083172979, 5509.779608815603, 5740.253767010262, 5741.511971482387, 5744.569157313218, 5745.368009518949, 5775.711214439261, 5813.476787089182, 5827.0, 5860.033094539439, 5869.882602347929, 5821.417858214145, 5821.912671309934, 5839.0, 5840.795572154954, 5850.23946886902, 5632.493075623213, 5655.208270842086, 5795.768169273266, 5855.473007429352, 5863.3257175424515, 4364.912701745948, 4374.343848422762, 4375.562443755663, 4413.051193993307, 4417.491988421372, 3892.2020985697864, 3906.1797022625565, 3910.7458015228917, 3928.155446578999, 3947.50656167979, 5340.225667278223, 5385.7576409061685, 5437.755301011464, 5442.863928401822, 5457.781688732406, 5766.625169363978, 5828.854278643068, 5854.531637468992, 5854.619449735754, 5897.49871260939, 5501.587380946445, 5519.089350257163, 5526.668399896019, 5528.9723551381985, 5533.335999680065, 4934.55588996992, 4947.0, 4957.3059771632, 5033.697978121324, 5093.490650934951, 5952.642841429528, 5956.4341387568975, 5958.851028724316, 5961.523078153824, 6000.249968753906, 5813.883722325614, 5822.301323841166, 5824.271966004249, 5828.562857785599, 5834.562407819346, 5834.358220595816, 5896.70516474166, 5953.404659534012, 5965.985782417087, 5974.880502389841, 5704.543636509153, 5749.8562535936935, 5751.568632352674, 5759.424057594375, 5762.8847423050465, 5858.7070646468355, 5867.149263356875, 5867.5305975521005, 5868.0, 5873.706314684334, 5401.054815407209, 5536.833894983157, 5552.750126244248, 5570.359408668055, 5614.29821272341, 5597.888042239051, 5602.775888964396, 5606.747696353592, 5609.775608975595, 5611.410801865909, 5461.453854614507, 5527.778888844401, 5555.22226888244, 5556.603118208047, 5560.582956278215, 5558.666480011212, 5561.165825126263, 5597.048501754793, 5677.971610141923, 5689.203511508309, 5478.863028424162, 5484.369297530676, 5486.231927530229, 5489.862753431196, 5492.395836458067], "value": 5339.294370851906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8248216776053, 629.7764293675742, 634.8793729191453, 643.1510406263734, 650.6779144323559, 32393.51409728853, 34921.82539087304, 34967.475487867705, 34994.650053499456, 43033.569664303424, 41337.793311033405, 45012.549874501245, 45047.77476112615, 45075.54924450754, 45127.0, 8898.66520021997, 9063.048379920112, 9064.27778722044, 9066.682666106688, 9067.909320906772, 8928.330375221853, 9044.412113212653, 9049.909500904972, 9050.77373065672, 9051.683191088314, 9050.683226087089, 9102.817943641123, 9103.63585456581, 9110.863337049916, 9113.40762850416, 8996.145366190234, 9039.231665308456, 9053.50205738684, 9055.95472022639, 9059.094090590954, 8915.28677705782, 8981.326400519987, 8987.505687187202, 8990.37067405282, 8990.685326013623, 42784.57215427868, 43088.78455607702, 43147.35278970818, 43157.0, 43182.784086079686, 3625.728070394731, 3732.64539868712, 3743.0455233915177, 3756.398976163801, 3988.2422339755353, 32309.83845080783, 32942.67057329444, 33051.33897322064, 34015.31969360599, 34316.48525272123, 4293.699441039129, 4340.110277393158, 4372.825086996516, 4388.561143885618, 4401.295792673157, 346900.0, 347216.0, 347366.2631686851, 348453.0, 349969.0, 56060.439395606336, 56316.43683563112, 56673.43326566764, 56707.716461418255, 56709.7164514183, 36580.0, 37624.247515049545, 60613.393866061655, 60679.393206067376, 60685.08972365418, 17807.46577602674, 17903.46289611314, 17972.19125139346, 17974.820251797315, 17975.640487190183, 13735.45058197681, 13834.723305533833, 13840.4463821446, 13841.446342146402, 13849.030567860153, 19860.304889328803, 19912.70130948037, 19997.700034499496, 20084.89957550203, 20095.799042009392, 6970.651467426608, 7066.827170422026, 7135.750248741373, 7147.642617869085, 7201.279872012861, 965.0, 1053.0973891339088, 1059.4014381874217, 1109.2124591539934, 1117.6144230240554, 32108.357832843212, 32169.195770105467, 32276.677233227838, 32323.51514727281, 32685.18287042843, 1019.2610357490908, 1101.262154356567, 1114.816055350858, 1138.3795831271977, 1160.7620437810397, 16328.591785205228, 16638.916805415894, 16640.50078497647, 16647.916760416363, 16685.165741712866, 566137.0, 570471.0, 571753.0, 571982.0, 572365.0, 58541.70729146327, 60028.69985650131, 60155.0, 60158.69920650369, 60161.699191503765, 1231.5689508672071, 1281.5642681488152, 1286.3696788573532, 1370.2189751841354, 1376.1330361872156, 25169.622455663546, 31635.84182079075, 32159.0, 32636.347273054882, 32821.835890820395, 57998.0, 58039.70980145072, 58757.70621146867, 58798.412015879294, 58814.705926470095, 489323.0, 495683.0, 495737.0, 496379.0, 496588.0, 32512.187195320304, 44731.776341118086, 45343.54656453525, 46642.0, 47183.528164717914, 47992.0, 48680.5131948676, 48733.0, 48829.0, 49152.26271606, 38502.22995540129, 40538.59461405348, 40647.18705625812, 40735.59264407318, 41204.38193427041, 39384.2123157541, 40140.46434576482, 40240.0, 40301.39547906725, 40966.590334096276, 31956.36087278288, 40489.79755101206, 40947.795261024694, 40965.38551921783, 41074.38388424236, 36354.4546831803, 37424.00607951303, 37636.435453467675, 37847.43228851514, 38531.2293754129, 27510.724892750815, 27525.862370688017, 27705.584416234175, 27921.301967450978, 27973.86013070003], "value": 20535.092923596505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.98972525686855, 413.6091393633017, 414.22953306849234, 420.17645414986623, 431.9740815551067, 13651.0, 17882.91058544707, 19377.806221937775, 19378.12798424071, 20434.69347959778, 17866.10669466528, 18671.626567468644, 18698.53253668659, 19279.903600482012, 19621.607567848634, 5379.408265090837, 5533.806316778913, 5539.25220095286, 5540.50135487806, 5564.554835613141, 4083.938740918874, 5534.889302213954, 5551.278333816618, 5554.2779438672915, 5578.609497335188, 5838.386969368219, 6125.72434240458, 6131.202943617323, 6260.843478913018, 6261.467775239087, 5976.64140151588, 6123.142760013579, 6185.536084793636, 6229.065640154013, 6251.656158911258, 5936.584439089265, 5936.7922122725495, 5943.762249510014, 5961.850953726148, 5965.403459654, 14859.257037148207, 14962.925185374004, 15304.770428443582, 15323.0, 15365.923170384189, 2361.1381845626393, 2407.265783935899, 2423.3578101803037, 2748.367875388672, 2967.95548066777, 10728.570857165703, 11211.71970700739, 11306.321620702784, 12746.362681865963, 14979.0, 1957.765068191826, 1967.4982879365814, 1993.4816947593586, 2018.3238615063972, 2036.4908772806798, 85341.57329213314, 86998.56500717519, 89139.55430222872, 89592.0, 90982.99999999935, 11429.942850285695, 11452.828207576893, 11620.825687614693, 11776.17566770335, 11869.881301186877, 16356.263968121226, 16468.505944821674, 16599.170041498117, 16667.583310417092, 16715.247813848408, 8608.440451370641, 8826.382153249338, 8875.378723489423, 8889.333300002396, 8965.506897120591, 8446.535440550828, 8557.058723540405, 8652.3510736695, 8693.174148455886, 8803.603837827313, 4938.4320803107385, 5000.574951129122, 5052.267421223975, 5103.0, 5201.063808514504, 1984.1269841270084, 2027.513396784761, 2031.7155598216261, 2060.546679730457, 2107.2519255664324, 862.4652715316544, 907.981840363189, 959.4770849886689, 960.3469640644289, 1008.8738907636546, 18145.7278140828, 19561.706574401396, 19566.608667826564, 19622.0, 20094.196232150844, 990.8166989107038, 1008.8991100889853, 1025.9538320775582, 1031.8142734307746, 1063.3088492479949, 10580.735481613021, 11298.491567879466, 11310.151738619636, 11369.147313951487, 11392.0, 483519.0, 488867.0, 490235.0, 490981.0, 494366.0, 74553.0, 96647.0, 101416.0, 103043.48478257711, 104985.0, 972.1056627902346, 981.0728861226073, 1066.642674703983, 1088.1458055426451, 1101.8512500812449, 17512.299508019536, 17586.472405827335, 17905.910470447565, 18109.366172184436, 18359.0, 44401.33397998968, 44486.55513444953, 44609.0, 44667.55332446634, 44890.77554612206, 53731.19403209033, 54336.728316359746, 62116.37883621287, 64101.0, 64170.0, 9295.442273463614, 9386.530673466435, 9544.188743956563, 9552.904470955202, 9634.71095867125, 13926.721465570834, 14124.50564230247, 14284.0, 14302.928485357506, 14831.777523336943, 11970.162088653711, 12012.63962081139, 12199.817002744789, 12278.386080696107, 12311.938440307742, 12138.33239171854, 12178.147529672839, 12314.445849936954, 12321.568745093879, 12389.380530973596, 12263.202891812003, 12280.938595306967, 12294.508219671114, 12295.200811947196, 12738.172018818746, 9410.81178376415, 9451.716448506555, 9486.28852836054, 9555.808883822423, 9712.70861874145, 9954.0, 12528.436220369922, 12573.434195461408, 12618.116731828684, 12625.368731563201], "value": 9515.358127548287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.5509649171033, 1429.076477998695, 1455.3087283540317, 1568.803899512561, 1714.091531488311, 8814.427062240959, 9166.450012999216, 9197.172254497094, 9412.482313472756, 9429.717108486739, 9068.274538036958, 9235.076492350761, 9277.489738064403, 9302.86045709315, 9308.674196403128, 2155.0948601587293, 2347.3544775186874, 2418.6251131074623, 2445.816563757721, 2490.066225165563, 2486.676732024834, 2493.9127130550432, 2497.2008957133635, 2498.088197807796, 2498.57524220882, 2408.7109546854313, 2468.111479867255, 2468.5309791139716, 2469.172827102923, 2472.0359059966627, 2084.395525297662, 2298.6666933294578, 2361.2916125162556, 2365.302235840423, 2375.2280508834697, 2408.5664580375524, 2441.9145329913367, 2446.54738873309, 2465.963010554843, 2468.7037555493275, 9513.619455221851, 9525.047495250488, 9576.329656924017, 9584.520773961343, 9589.18491928187, 5512.972435137839, 5650.350209725893, 5655.5475561954945, 5656.660600363992, 5662.094064949588, 3501.7215985017733, 3536.929261414783, 3609.4946707460977, 3649.817509124533, 3702.2780557791243, 1211.485118824505, 1216.6714986953561, 1237.3503910446998, 1263.2357423758585, 1266.2529107826426, 13399.330033498383, 13474.595762127054, 13475.528356507573, 13484.460621575125, 13485.460581576725, 5058.494150584986, 5059.215821547666, 5060.063888180698, 5060.620453466005, 5151.665141765773, 11148.052415544607, 11236.381998990135, 11242.55029798799, 11243.831342529706, 11263.718407039889, 5605.80379686709, 5607.49532542065, 5612.579056570774, 5613.803516876889, 5616.129499927518, 4495.325701144789, 4931.50684931504, 5080.263361812516, 5080.59355251579, 5167.948320516747, 4145.3781932709735, 4177.665786737054, 4251.744895306291, 4268.125034367947, 4285.292926667065, 1263.1266833040834, 1283.8972882169403, 1286.7040580666498, 1287.1697754948007, 1300.109425043829, 993.1607791416242, 995.1640621877658, 1003.1773945364877, 1019.7603563162651, 1038.693585392311, 6259.593126446766, 6345.0, 6480.643564603898, 6606.966965165239, 6646.003099535108, 479.4270846338662, 487.19369443570946, 492.45829587453517, 496.3299545613393, 496.3919198981219, 4497.527759585262, 4499.212637788374, 4521.660875434355, 4551.385562949025, 4577.679562430664, 11351.432428378714, 11708.356040417688, 11764.294142351315, 11770.52917883275, 11782.823257651142, 11242.807652507683, 11452.083833293316, 11640.94179529097, 11699.2980421175, 11969.700757481132, 8633.95683021581, 8744.213020828156, 8754.0, 8796.604152813139, 8806.207441330183, 6277.780277690259, 6588.637624930675, 6719.932800671931, 6727.394534491919, 6800.353966373186, 10354.17166626653, 10729.517171727448, 11050.889491104987, 11145.777084458428, 11224.494897729459, 10971.561137554409, 11207.887921121011, 11260.0, 11352.262102963281, 11367.033802126582, 7438.256174382518, 7607.049118860143, 7613.847723045619, 8403.243708066304, 8576.056633770406, 8652.524111173945, 8923.955380223057, 9223.0, 9224.538773061455, 9507.191888689538, 8086.757397278091, 8212.671493140208, 8333.874991875005, 8344.457610255315, 8398.832023359377, 8006.1993800619475, 8150.184981501802, 8273.586320683822, 8279.296259817984, 8282.0, 7351.8529629408185, 7379.631018449163, 7696.615169241628, 7705.691772329044, 7706.730264440717, 5498.835034948958, 5520.1167813149705, 5538.141588053858, 5544.889102218014, 5815.447532484407, 5571.749271282721, 5583.720813959367, 5693.686847223443, 5742.913856292075, 5772.769089236552], "value": 4846.370085130583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.5429809800113, 348.51730353460465, 358.24053007623843, 360.1302853608536, 361.41811683190076, 5341.706206158659, 5424.566034717223, 5440.265564148839, 5441.0, 5445.782168713246, 5324.813631522898, 5330.387005494369, 5344.893102137955, 5357.517823395893, 5369.0, 3985.2826491231567, 4240.257954857888, 4250.2137104635585, 4261.764088414356, 4290.141971605676, 4168.687348448863, 4214.388913607525, 4245.0, 4249.490061192646, 4261.659067274626, 4000.83975647062, 4089.7546147231114, 4186.874393768192, 4201.306784380574, 4201.642860356873, 4155.750654960712, 4156.542780294165, 4157.085441202946, 4164.66682665386, 4167.2082304362075, 3683.465897444882, 3699.907502312437, 3707.5736290326417, 3712.5706602958057, 3728.5525736911472, 4985.476524964899, 5031.371078615173, 5168.767405466763, 5237.738113094369, 5273.551748101416, 4732.574068333832, 4738.857834264943, 4758.0, 4766.856994290177, 4786.808527658889, 5476.507114359687, 5524.088525393306, 5533.861653458655, 5590.748416321276, 5666.773329066832, 3884.1454879926373, 4036.1120553478186, 4082.183563287325, 4082.9387559186634, 4105.158442519277, 5816.680082595455, 5819.817568411846, 5840.795572154997, 5844.1818145459665, 5859.736311865976, 4153.501579810442, 4159.334506478949, 4159.729617574848, 4159.771212583337, 4182.142660754538, 4149.647279981175, 4215.683823713233, 4217.704760666724, 4244.702870799015, 4252.638525725286, 4765.1660959331975, 4780.737059461763, 4783.397561816831, 4827.348307978378, 4829.082474329866, 5665.6034077614995, 5684.34630017545, 5730.0, 5745.195672605839, 5747.1379293106365, 1430.9212993285262, 1447.6887469194173, 1452.192020933944, 1452.4988878836784, 1457.9343929523197, 924.1682485762867, 935.3779736475303, 939.0656296984407, 947.6114792934864, 950.273041123541, 4823.601155664888, 4877.341558889575, 4890.437599676012, 4895.559399654048, 4907.779149938261, 5119.513646203604, 5127.666806630228, 5155.175171972466, 5201.635885487979, 5214.843554693365, 4913.729744864067, 5211.0, 5305.65513241638, 5423.511883930386, 5459.071957767189, 3038.468268053082, 3049.1767222849708, 3079.2609773654162, 3082.027502398467, 3092.737117345051, 5764.510016648632, 5921.911171332347, 5969.194158788595, 5972.313183983897, 5972.462478376967, 5938.584299099021, 5946.940530594725, 5971.611845230046, 5972.790952316648, 5980.312264089685, 5821.224526519283, 5979.9402005980255, 6011.489023433057, 6020.217371741734, 6047.909281360695, 5650.802221922213, 5769.826905192851, 5773.53811695055, 5796.362400135898, 5811.128330750421, 5590.468905453975, 5668.773249069991, 5711.257536520226, 5760.164776107525, 5766.693322670965, 5637.154426836008, 5855.8536036597725, 5904.675242861512, 5927.496162826208, 5962.284525856751, 4260.339647354665, 4298.441202643637, 4299.914001719885, 4310.806013729452, 4311.913761724811, 5814.709264536672, 5815.360310365941, 5823.272090988627, 5824.815694114707, 5838.1826544282985, 5551.444855514416, 5567.610267281251, 5581.274434323512, 5603.80386686464, 5713.771449141987, 5528.281323427928, 5536.501714845684, 5549.1676248563035, 5584.525315348241, 5598.664080155204, 5448.618596698193, 5449.555867695143, 5476.780928762805, 5514.393416724238, 5530.834074977757, 5339.786408543615, 5625.8593535161945, 5630.718464076698, 5632.577556683347, 5648.971755141198, 5288.4182739897815, 5477.972610136924, 5485.232067510631, 5486.643368181056, 5519.172124181405], "value": 4276.919594204941, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.0400814912092, 744.2483092077003, 765.7855800375889, 800.8358286551256, 858.4205661178706, 14432.711345773092, 14452.205128717917, 14573.05275157114, 14602.780958285633, 14621.561353159408, 14787.556373308818, 14853.331600077996, 14878.925605371958, 14902.031367961075, 14926.850731492681, 642.0433554004522, 763.0652450747831, 777.9299863012328, 779.9064112306503, 779.9337056350189, 758.7420277105783, 769.4921351907742, 773.6711897443593, 776.8834674798769, 783.725696006399, 823.4153750836913, 831.787894087007, 834.6369329341726, 835.5488036460304, 835.9832803343929, 675.7432175773224, 803.04036676172, 831.4221615976899, 831.5343407691681, 831.9126491718373, 603.1254680712984, 605.1165298663956, 606.754264522869, 607.0378450156508, 607.2864384348374, 15590.142542160176, 15604.063756174666, 15613.843861561467, 15649.765253521093, 15666.0, 14088.506902258474, 14411.92794036023, 14424.423023079169, 14427.855721442756, 14830.555083347517, 12876.484940602364, 12914.741705165938, 13120.212787232796, 13128.6717832054, 13261.801072983913, 4399.560043995607, 4453.153900758845, 4488.5960263576435, 4648.070385922829, 4687.086018226447, 80551.597242014, 82132.17867821305, 82262.0, 82857.0, 84073.57963210145, 11489.42552872353, 11658.708532286591, 11658.70853228676, 11778.823317650242, 11982.10134239918, 22408.66387004196, 22446.77553224447, 22504.662430063563, 22509.43726406853, 22547.43631409228, 8098.878516822252, 8170.182981701782, 8216.178382161735, 8346.332293416634, 8426.031006434216, 4363.825446982085, 4526.91497467619, 4527.683062185682, 4528.43394575678, 4660.580547750718, 3548.822558872046, 3639.636036396339, 3657.9268414632093, 3663.395539735967, 3668.0829792551863, 608.3672980100646, 610.5542953643865, 612.1949636228435, 612.295859761278, 612.3753771153398, 533.6264614769676, 608.333874407523, 713.293839099288, 758.2569082299377, 758.9022206570182, 9583.939453017634, 9874.358166719141, 10004.599816007278, 10118.59525618967, 10216.284860059724, 702.8102412348637, 741.3698356397019, 752.860720766649, 753.1978442958232, 754.0410962292941, 4282.164977829293, 4618.1918164321105, 4680.976595117071, 4978.502149785065, 5252.632315737938, 124267.0, 128353.35823320823, 129425.0, 130273.0, 130758.0, 80272.0, 80426.59786701029, 80810.0, 94664.0, 95780.0, 84485.0, 86288.56855715682, 87666.56166719254, 88566.55716721374, 89174.0, 10121.342112762646, 10154.492275386054, 10207.336523125972, 10262.384256944608, 10277.280590358603, 50300.49699502958, 50445.49554504408, 50720.74639626778, 50928.0, 51547.22679159741, 50910.74544627401, 51006.48993510017, 57685.0, 72232.27767722255, 74780.0, 12884.291363975071, 12985.415656295678, 13195.274259915797, 13405.320642923534, 14035.228062456663, 13980.790288145889, 14742.557723268319, 14823.481178158712, 14951.476698315506, 14955.551333460013, 14024.29878506091, 14145.222012789396, 14306.213158276394, 15206.543803685907, 15227.619309517351, 12829.10196286251, 13690.589282321545, 13815.0, 13842.169469831842, 14073.155610663393, 13513.594592162252, 13675.658108547366, 14124.646883827987, 14247.928760356132, 14554.781678274623, 11633.360165190996, 11924.0, 12045.277283363026, 12197.207181533173, 12241.693957650774, 11605.593804216813, 12039.277643341427, 12075.652286617169, 12353.62939111828, 12422.440990155284], "value": 7613.994568476541, "unit": "score"}], "name": "dromaeo_css", "value": 7403.4652314304285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 138.0, 187.0, 126.0, 126.0, 146.0, 125.0, 172.0, 130.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 159.0, 160.0, 159.0, 159.0, 160.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 116.0, 74.0, 76.0, 75.0, 75.0, 99.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 84.0, 97.0, 120.0, 84.0, 85.0, 128.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 152.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 54.0, 53.0, 51.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 79.0, 80.0, 79.0, 79.0, 118.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 139.0, 122.0, 121.0, 128.0, 129.0, 130.0, 127.0, 125.0, 122.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 159.0, 165.0, 159.0, 161.0, 163.0, 161.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 63.0, 65.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1496.2000000000003, "alertThreshold": 2.0}]} 13:37:13 INFO - Return code: 0 13:37:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:13 INFO - # TBPL SUCCESS # 13:37:13 INFO - Running post-action listener: _resource_record_post_action 13:37:13 INFO - ##### 13:37:13 INFO - ##### Finished run-tests step (success) 13:37:13 INFO - ##### 13:37:13 INFO - Running post-run listener: _resource_record_post_run 13:37:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560037888; Read time: 12; Write time: 472832 13:37:13 INFO - TinderboxPrint: CPU usage
13.2% 13:37:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:37:13 INFO - TinderboxPrint: I/O write bytes / time
560,037,888 / 472,832 13:37:13 INFO - TinderboxPrint: CPU idle
8,269.1 (86.8%) 13:37:13 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 13:37:13 INFO - TinderboxPrint: Swap in / out
0 / 0 13:37:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 239738880; Read time: 0; Write time: 234588 13:37:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292405248; Read time: 12; Write time: 209376 13:37:13 INFO - Running post-run listener: _upload_blobber_files 13:37:13 INFO - Blob upload gear active. 13:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:13 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 13:37:13 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'] 13:37:13 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 13:37:14 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:14 INFO - (blobuploader) - INFO - Done attempting. 13:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:18 INFO - (blobuploader) - INFO - Done attempting. 13:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:19 INFO - (blobuploader) - INFO - Done attempting. 13:37:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:19 INFO - Return code: 0 13:37:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/070d70efdb9a091a66783f839eadab3b8ebf66fc38570b22881f40add452a3ed90b035ae91d7902c3ecfa4f0f619731da72bf872613e4e6aa7262d625dddd278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69d0ff62f584fceef388b5dc9fcd79fd137adcda2dde11e87b7717e4529002b4de28ea1793734eabd7835e3235a12aa92a645bbfcb323c2065fa7b74cb7b7f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb42fd3fcdf99baafbf7a1a865cb1d04146b3426007ff75acb333f02f8082c1f0288c24c17a84eb123b7b381a25ac640bdcab65dcbe9341cf271dfc30fbac2c1"} 13:37:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:19 INFO - Contents: 13:37:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/070d70efdb9a091a66783f839eadab3b8ebf66fc38570b22881f40add452a3ed90b035ae91d7902c3ecfa4f0f619731da72bf872613e4e6aa7262d625dddd278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69d0ff62f584fceef388b5dc9fcd79fd137adcda2dde11e87b7717e4529002b4de28ea1793734eabd7835e3235a12aa92a645bbfcb323c2065fa7b74cb7b7f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb42fd3fcdf99baafbf7a1a865cb1d04146b3426007ff75acb333f02f8082c1f0288c24c17a84eb123b7b381a25ac640bdcab65dcbe9341cf271dfc30fbac2c1"} 13:37:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:19 INFO - Copying logs to upload dir... 13:37:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.696233 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-12 13:37:18.862038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 13:37:18.866187) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 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/070d70efdb9a091a66783f839eadab3b8ebf66fc38570b22881f40add452a3ed90b035ae91d7902c3ecfa4f0f619731da72bf872613e4e6aa7262d625dddd278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69d0ff62f584fceef388b5dc9fcd79fd137adcda2dde11e87b7717e4529002b4de28ea1793734eabd7835e3235a12aa92a645bbfcb323c2065fa7b74cb7b7f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb42fd3fcdf99baafbf7a1a865cb1d04146b3426007ff75acb333f02f8082c1f0288c24c17a84eb123b7b381a25ac640bdcab65dcbe9341cf271dfc30fbac2c1"} build_url:https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/IwzIoqC9ROiuzBjDRXZ_XQ/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/070d70efdb9a091a66783f839eadab3b8ebf66fc38570b22881f40add452a3ed90b035ae91d7902c3ecfa4f0f619731da72bf872613e4e6aa7262d625dddd278", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69d0ff62f584fceef388b5dc9fcd79fd137adcda2dde11e87b7717e4529002b4de28ea1793734eabd7835e3235a12aa92a645bbfcb323c2065fa7b74cb7b7f52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb42fd3fcdf99baafbf7a1a865cb1d04146b3426007ff75acb333f02f8082c1f0288c24c17a84eb123b7b381a25ac640bdcab65dcbe9341cf271dfc30fbac2c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 13:37:18.894219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:37:18.894720) ========= 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=a0d2d2de893abaa8702a9954000001a7-1465746534.504543-1808623379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 13:37:18.979031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 13:37:18.979499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 13:37:18.979948) ========= ========= Total master_lag: 0.19 =========