builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1465438167.74 results: success (0) buildid: 20160608163004 builduid: 7713e4fd0e3444c68c45b3e76da34958 revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.738587) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.739397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.739764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.755618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.756051) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 19:09:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2016-06-08 19:09:27 (13.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.893396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.893727) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.943394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:27.943804) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 19:09:28,087 truncating revision to first 12 chars 2016-06-08 19:09:28,087 Setting DEBUG logging. 2016-06-08 19:09:28,087 attempt 1/10 2016-06-08 19:09:28,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/051765f8237d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 19:09:28,407 unpacking tar archive at: mozilla-central-051765f8237d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663832 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:28.621291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:28.621675) ========= script_repo_revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:28.622103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:28.622407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 19:09:28.631616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-08 19:09:28.631939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:09:28 INFO - MultiFileLogger online at 20160608 19:09:28 in /builds/slave/test 19:09:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:09:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:28 INFO - {'append_to_log': False, 19:09:28 INFO - 'base_work_dir': '/builds/slave/test', 19:09:28 INFO - 'blob_upload_branch': 'Firefox', 19:09:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:28 INFO - 'branch': 'Firefox', 19:09:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:28 INFO - 'config_files': ('talos/linux_config.py',), 19:09:28 INFO - 'default_actions': ('clobber', 19:09:28 INFO - 'read-buildbot-config', 19:09:28 INFO - 'download-and-extract', 19:09:28 INFO - 'populate-webroot', 19:09:28 INFO - 'create-virtualenv', 19:09:28 INFO - 'install', 19:09:28 INFO - 'run-tests'), 19:09:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:28 INFO - 'download_minidump_stackwalk': True, 19:09:28 INFO - 'download_symbols': 'ondemand', 19:09:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:28 INFO - 'installer_path': 'installer.exe', 19:09:28 INFO - 'log_level': 'info', 19:09:28 INFO - 'log_name': 'talos', 19:09:28 INFO - 'log_to_console': True, 19:09:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:09:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:09:28 INFO - 'opt_config_files': (), 19:09:28 INFO - 'pip_index': False, 19:09:28 INFO - 'sps_profile': False, 19:09:28 INFO - 'sps_profile_interval': 0, 19:09:28 INFO - 'suite': 'dromaeojs-e10s', 19:09:28 INFO - 'system_bits': '32', 19:09:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:28 INFO - 'title': 'talos-linux64-ix-011', 19:09:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:28 INFO - 'use_talos_json': True, 19:09:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:28 INFO - 'work_dir': 'build'} 19:09:28 INFO - ##### 19:09:28 INFO - ##### Running clobber step. 19:09:28 INFO - ##### 19:09:28 INFO - Running pre-action listener: _resource_record_pre_action 19:09:28 INFO - Running main action method: clobber 19:09:28 INFO - rmtree: /builds/slave/test/build 19:09:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:29 INFO - Running post-action listener: _resource_record_post_action 19:09:29 INFO - ##### 19:09:29 INFO - ##### Finished clobber step (success) 19:09:29 INFO - ##### 19:09:29 INFO - ##### 19:09:29 INFO - ##### Running read-buildbot-config step. 19:09:29 INFO - ##### 19:09:29 INFO - Running pre-action listener: _resource_record_pre_action 19:09:29 INFO - Running main action method: read_buildbot_config 19:09:29 INFO - Using buildbot properties: 19:09:29 INFO - { 19:09:29 INFO - "project": "", 19:09:29 INFO - "product": "firefox", 19:09:29 INFO - "script_repo_revision": "production", 19:09:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:09:29 INFO - "repository": "", 19:09:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:09:29 INFO - "buildid": "20160608163004", 19:09:29 INFO - "pgo_build": "True", 19:09:29 INFO - "basedir": "/builds/slave/test", 19:09:29 INFO - "buildnumber": 745, 19:09:29 INFO - "slavename": "talos-linux64-ix-011", 19:09:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:09:29 INFO - "platform": "ubuntu64_hw", 19:09:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:09:29 INFO - "branch": "mozilla-central", 19:09:29 INFO - "repo_path": "mozilla-central", 19:09:29 INFO - "revision": "051765f8237daf5da7ba0d3e97da16668ce9988c", 19:09:29 INFO - "stage_platform": "linux64-pgo", 19:09:29 INFO - "builduid": "7713e4fd0e3444c68c45b3e76da34958", 19:09:29 INFO - "slavebuilddir": "test" 19:09:29 INFO - } 19:09:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:09:29 INFO - Running post-action listener: _resource_record_post_action 19:09:29 INFO - ##### 19:09:29 INFO - ##### Finished read-buildbot-config step (success) 19:09:29 INFO - ##### 19:09:29 INFO - ##### 19:09:29 INFO - ##### Running download-and-extract step. 19:09:29 INFO - ##### 19:09:29 INFO - Running pre-action listener: _resource_record_pre_action 19:09:29 INFO - Running main action method: download_and_extract 19:09:29 INFO - mkdir: /builds/slave/test/build/tests 19:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:29 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:30 INFO - Downloaded 1361 bytes. 19:09:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:30 INFO - Using the following test package requirements: 19:09:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:09:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:09:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'jsshell-linux-x86_64.zip'], 19:09:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:09:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:09:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:09:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:09:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:09:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:09:30 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')]} 19:09:30 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:31 INFO - Downloaded 24451218 bytes. 19:09:31 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'] 19:09:31 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 19:09:32 INFO - Return code: 0 19:09:32 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 19:09:32 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')]} 19:09:32 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:34 INFO - Downloaded 24451218 bytes. 19:09:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:09:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:09:35 INFO - Return code: 0 19:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:35 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:36 INFO - Downloaded 10833369 bytes. 19:09:36 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'] 19:09:36 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 19:09:37 INFO - Return code: 0 19:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:37 INFO - https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eY2UHyDBTzqgCc2kspjWxg/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 19:09:38 INFO - Downloaded 59273696 bytes. 19:09:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:09:38 INFO - mkdir: /builds/slave/test/properties 19:09:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:38 INFO - Contents: 19:09:38 INFO - build_url:https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:09:39 INFO - Running post-action listener: _resource_record_post_action 19:09:39 INFO - Running post-action listener: set_extra_try_arguments 19:09:39 INFO - ##### 19:09:39 INFO - ##### Finished download-and-extract step (success) 19:09:39 INFO - ##### 19:09:39 INFO - ##### 19:09:39 INFO - ##### Running populate-webroot step. 19:09:39 INFO - ##### 19:09:39 INFO - Running pre-action listener: _resource_record_pre_action 19:09:39 INFO - Running main action method: populate_webroot 19:09:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:39 INFO - '--tppagecycles', 19:09:39 INFO - '7'], 19:09:39 INFO - 'tests': ['tsvgm']}}, 19:09:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:09:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:09:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['damp', 'tps']}, 19:09:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'tests': ['damp', 'tps']}, 19:09:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['dromaeo_dom']}, 19:09:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'other-e10s': {'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['a11yr', 19:09:39 INFO - 'ts_paint', 19:09:39 INFO - 'tpaint', 19:09:39 INFO - 'sessionrestore', 19:09:39 INFO - 'sessionrestore_no_auto_restore', 19:09:39 INFO - 'tabpaint']}, 19:09:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['tsvgx', 19:09:39 INFO - 'tsvgr_opacity', 19:09:39 INFO - 'tart', 19:09:39 INFO - 'tscrollx', 19:09:39 INFO - 'cart']}, 19:09:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:09:39 INFO - 'tsvgr_opacity', 19:09:39 INFO - 'tart', 19:09:39 INFO - 'tscrollx', 19:09:39 INFO - 'cart']}, 19:09:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'talos_options': ['--disable-e10s'], 19:09:39 INFO - 'tests': ['tp5o']}, 19:09:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'tests': ['tp5o']}, 19:09:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'talos_options': ['--disable-e10s', 19:09:39 INFO - '--xperf_path', 19:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:39 INFO - 'tests': ['tp5n']}, 19:09:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:39 INFO - 'talos_options': ['--xperf_path', 19:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:39 INFO - 'tests': ['tp5n']}}, 19:09:39 INFO - 'talos.zip': {'path': '', 19:09:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:39 INFO - Running post-action listener: _resource_record_post_action 19:09:39 INFO - ##### 19:09:39 INFO - ##### Finished populate-webroot step (success) 19:09:39 INFO - ##### 19:09:39 INFO - ##### 19:09:39 INFO - ##### Running create-virtualenv step. 19:09:39 INFO - ##### 19:09:39 INFO - Running pre-action listener: _resource_record_pre_action 19:09:39 INFO - Running main action method: create_virtualenv 19:09:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:39 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 19:09:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:39 INFO - Using real prefix '/usr' 19:09:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:42 INFO - Installing pip.................done. 19:09:42 INFO - Return code: 0 19:09:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:42 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 19:09:42 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 19:09:42 INFO - Using env: {'DISPLAY': ':0', 19:09:42 INFO - 'HOME': '/home/cltbld', 19:09:42 INFO - 'LANG': 'en_US.UTF-8', 19:09:42 INFO - 'LANGUAGE': 'en_US:en', 19:09:42 INFO - 'LOGNAME': 'cltbld', 19:09:42 INFO - 'MAIL': '/var/mail/cltbld', 19:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:42 INFO - 'MOZ_NO_REMOTE': '1', 19:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:42 INFO - 'NO_EM_RESTART': '1', 19:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:42 INFO - 'PWD': '/builds/slave/test', 19:09:42 INFO - 'SHELL': '/bin/bash', 19:09:42 INFO - 'SHLVL': '1', 19:09:42 INFO - 'TERM': 'linux', 19:09:42 INFO - 'TMOUT': '86400', 19:09:42 INFO - 'USER': 'cltbld', 19:09:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:42 INFO - '_': '/tools/buildbot/bin/python'} 19:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:42 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 19:09:42 INFO - Cleaning up... 19:09:42 INFO - Return code: 0 19:09:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:42 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 19:09:42 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 19:09:42 INFO - Using env: {'DISPLAY': ':0', 19:09:42 INFO - 'HOME': '/home/cltbld', 19:09:42 INFO - 'LANG': 'en_US.UTF-8', 19:09:42 INFO - 'LANGUAGE': 'en_US:en', 19:09:42 INFO - 'LOGNAME': 'cltbld', 19:09:42 INFO - 'MAIL': '/var/mail/cltbld', 19:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:42 INFO - 'MOZ_NO_REMOTE': '1', 19:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:42 INFO - 'NO_EM_RESTART': '1', 19:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:42 INFO - 'PWD': '/builds/slave/test', 19:09:42 INFO - 'SHELL': '/bin/bash', 19:09:42 INFO - 'SHLVL': '1', 19:09:42 INFO - 'TERM': 'linux', 19:09:42 INFO - 'TMOUT': '86400', 19:09:42 INFO - 'USER': 'cltbld', 19:09:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:42 INFO - '_': '/tools/buildbot/bin/python'} 19:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:42 INFO - Downloading/unpacking psutil>=3.1.1 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:44 INFO - Installing collected packages: psutil 19:09:44 INFO - Running setup.py install for psutil 19:09:44 INFO - building 'psutil._psutil_linux' extension 19:09:44 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 19:09:45 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 19:09:45 INFO - building 'psutil._psutil_posix' extension 19:09:45 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 19:09:45 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 19:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:45 INFO - Successfully installed psutil 19:09:45 INFO - Cleaning up... 19:09:45 INFO - Return code: 0 19:09:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:09:45 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')]} 19:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:45 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')]} 19:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:45 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:45 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 19:09:45 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 19:09:45 INFO - Using env: {'DISPLAY': ':0', 19:09:45 INFO - 'HOME': '/home/cltbld', 19:09:45 INFO - 'LANG': 'en_US.UTF-8', 19:09:45 INFO - 'LANGUAGE': 'en_US:en', 19:09:45 INFO - 'LOGNAME': 'cltbld', 19:09:45 INFO - 'MAIL': '/var/mail/cltbld', 19:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:45 INFO - 'MOZ_NO_REMOTE': '1', 19:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:45 INFO - 'NO_EM_RESTART': '1', 19:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:45 INFO - 'PWD': '/builds/slave/test', 19:09:45 INFO - 'SHELL': '/bin/bash', 19:09:45 INFO - 'SHLVL': '1', 19:09:45 INFO - 'TERM': 'linux', 19:09:45 INFO - 'TMOUT': '86400', 19:09:45 INFO - 'USER': 'cltbld', 19:09:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:45 INFO - '_': '/tools/buildbot/bin/python'} 19:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:09:47 INFO - Installing collected packages: mozsystemmonitor 19:09:47 INFO - Running setup.py install for mozsystemmonitor 19:09:47 INFO - Successfully installed mozsystemmonitor 19:09:47 INFO - Cleaning up... 19:09:47 INFO - Return code: 0 19:09:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:09:47 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')]} 19:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:47 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')]} 19:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:47 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:47 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 19:09:47 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 19:09:47 INFO - Using env: {'DISPLAY': ':0', 19:09:47 INFO - 'HOME': '/home/cltbld', 19:09:47 INFO - 'LANG': 'en_US.UTF-8', 19:09:47 INFO - 'LANGUAGE': 'en_US:en', 19:09:47 INFO - 'LOGNAME': 'cltbld', 19:09:47 INFO - 'MAIL': '/var/mail/cltbld', 19:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:47 INFO - 'MOZ_NO_REMOTE': '1', 19:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:47 INFO - 'NO_EM_RESTART': '1', 19:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:47 INFO - 'PWD': '/builds/slave/test', 19:09:47 INFO - 'SHELL': '/bin/bash', 19:09:47 INFO - 'SHLVL': '1', 19:09:47 INFO - 'TERM': 'linux', 19:09:47 INFO - 'TMOUT': '86400', 19:09:47 INFO - 'USER': 'cltbld', 19:09:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:47 INFO - '_': '/tools/buildbot/bin/python'} 19:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:09:47 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 19:09:47 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 19:09:47 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 19:09:47 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 19:09:47 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 19:09:47 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 19:09:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:49 INFO - warning: no files found matching '*.txt' 19:09:49 INFO - no previously-included directories found matching 'build' 19:09:49 INFO - no previously-included directories found matching 'dist' 19:09:49 INFO - no previously-included directories found matching '.git*' 19:09:49 INFO - Installing collected packages: jsonschema, functools32 19:09:50 INFO - Running setup.py install for functools32 19:09:50 INFO - warning: no files found matching '*.txt' 19:09:50 INFO - no previously-included directories found matching 'build' 19:09:50 INFO - no previously-included directories found matching 'dist' 19:09:50 INFO - no previously-included directories found matching '.git*' 19:09:50 INFO - Successfully installed jsonschema functools32 19:09:50 INFO - Cleaning up... 19:09:50 INFO - Return code: 0 19:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:50 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:50 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 19:09:50 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 19:09:50 INFO - Using env: {'DISPLAY': ':0', 19:09:50 INFO - 'HOME': '/home/cltbld', 19:09:50 INFO - 'LANG': 'en_US.UTF-8', 19:09:50 INFO - 'LANGUAGE': 'en_US:en', 19:09:50 INFO - 'LOGNAME': 'cltbld', 19:09:50 INFO - 'MAIL': '/var/mail/cltbld', 19:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:50 INFO - 'MOZ_NO_REMOTE': '1', 19:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:50 INFO - 'NO_EM_RESTART': '1', 19:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:50 INFO - 'PWD': '/builds/slave/test', 19:09:50 INFO - 'SHELL': '/bin/bash', 19:09:50 INFO - 'SHLVL': '1', 19:09:50 INFO - 'TERM': 'linux', 19:09:50 INFO - 'TMOUT': '86400', 19:09:50 INFO - 'USER': 'cltbld', 19:09:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:50 INFO - '_': '/tools/buildbot/bin/python'} 19:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:50 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 19:09:50 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 19:09:50 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 19:09:50 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 19:09:50 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 19:09:50 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 19:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:52 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 19:09:53 INFO - Downloading docopt-0.6.1.tar.gz 19:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:53 INFO - Running setup.py install for blobuploader 19:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:53 INFO - Running setup.py install for requests 19:09:53 INFO - Running setup.py install for docopt 19:09:53 INFO - Successfully installed blobuploader requests docopt 19:09:53 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:53 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 19:09:53 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 19:09:53 INFO - Using env: {'DISPLAY': ':0', 19:09:53 INFO - 'HOME': '/home/cltbld', 19:09:53 INFO - 'LANG': 'en_US.UTF-8', 19:09:53 INFO - 'LANGUAGE': 'en_US:en', 19:09:53 INFO - 'LOGNAME': 'cltbld', 19:09:53 INFO - 'MAIL': '/var/mail/cltbld', 19:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:53 INFO - 'MOZ_NO_REMOTE': '1', 19:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:53 INFO - 'NO_EM_RESTART': '1', 19:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:53 INFO - 'PWD': '/builds/slave/test', 19:09:53 INFO - 'SHELL': '/bin/bash', 19:09:53 INFO - 'SHLVL': '1', 19:09:53 INFO - 'TERM': 'linux', 19:09:53 INFO - 'TMOUT': '86400', 19:09:53 INFO - 'USER': 'cltbld', 19:09:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:53 INFO - '_': '/tools/buildbot/bin/python'} 19:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:54 INFO - Running setup.py (path:/tmp/pip-BHtQ3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:54 INFO - Running setup.py (path:/tmp/pip-xvHeJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:54 INFO - Running setup.py (path:/tmp/pip-wkcUW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:54 INFO - Running setup.py (path:/tmp/pip-uRghk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:54 INFO - Running setup.py (path:/tmp/pip-VSckfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:54 INFO - Running setup.py (path:/tmp/pip-1QfJVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:54 INFO - Running setup.py (path:/tmp/pip-elAXoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:54 INFO - Running setup.py (path:/tmp/pip-WlJFRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:54 INFO - Running setup.py (path:/tmp/pip-wZJrGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:54 INFO - Running setup.py (path:/tmp/pip-8nShDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:54 INFO - Running setup.py (path:/tmp/pip-JcC552-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:54 INFO - Running setup.py (path:/tmp/pip-qhZ0ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:54 INFO - Running setup.py (path:/tmp/pip-ZVAF9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:54 INFO - Running setup.py (path:/tmp/pip-vzXatI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:55 INFO - Running setup.py (path:/tmp/pip-Koh1qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:55 INFO - Running setup.py (path:/tmp/pip-zZCEfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:55 INFO - Running setup.py (path:/tmp/pip-xERnwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:55 INFO - Running setup.py install for manifestparser 19:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:55 INFO - Running setup.py install for mozcrash 19:09:55 INFO - Running setup.py install for mozdebug 19:09:55 INFO - Running setup.py install for mozdevice 19:09:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:55 INFO - Running setup.py install for mozfile 19:09:55 INFO - Running setup.py install for mozhttpd 19:09:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:55 INFO - Running setup.py install for mozinfo 19:09:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:55 INFO - Running setup.py install for mozInstall 19:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Running setup.py install for mozleak 19:09:56 INFO - Running setup.py install for mozlog 19:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Running setup.py install for moznetwork 19:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Running setup.py install for mozprocess 19:09:56 INFO - Running setup.py install for mozprofile 19:09:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Running setup.py install for mozrunner 19:09:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:56 INFO - Running setup.py install for mozscreenshot 19:09:56 INFO - Running setup.py install for moztest 19:09:56 INFO - Running setup.py install for mozversion 19:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:57 INFO - Cleaning up... 19:09:57 INFO - Return code: 0 19:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:57 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:09:57 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 19:09:57 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 19:09:57 INFO - Using env: {'DISPLAY': ':0', 19:09:57 INFO - 'HOME': '/home/cltbld', 19:09:57 INFO - 'LANG': 'en_US.UTF-8', 19:09:57 INFO - 'LANGUAGE': 'en_US:en', 19:09:57 INFO - 'LOGNAME': 'cltbld', 19:09:57 INFO - 'MAIL': '/var/mail/cltbld', 19:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:57 INFO - 'MOZ_NO_REMOTE': '1', 19:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:57 INFO - 'NO_EM_RESTART': '1', 19:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:57 INFO - 'PWD': '/builds/slave/test', 19:09:57 INFO - 'SHELL': '/bin/bash', 19:09:57 INFO - 'SHLVL': '1', 19:09:57 INFO - 'TERM': 'linux', 19:09:57 INFO - 'TMOUT': '86400', 19:09:57 INFO - 'USER': 'cltbld', 19:09:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:57 INFO - '_': '/tools/buildbot/bin/python'} 19:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:57 INFO - Running setup.py (path:/tmp/pip-gmKjON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:57 INFO - Running setup.py (path:/tmp/pip-qo5hD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:57 INFO - Running setup.py (path:/tmp/pip-DM0ZUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:57 INFO - Running setup.py (path:/tmp/pip-mK9MIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:57 INFO - Running setup.py (path:/tmp/pip-lvMz60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:57 INFO - Running setup.py (path:/tmp/pip-Jz3DBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:57 INFO - Running setup.py (path:/tmp/pip-symPnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:57 INFO - Running setup.py (path:/tmp/pip-9K61Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:57 INFO - Running setup.py (path:/tmp/pip-MGTRkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:57 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)) 19:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:57 INFO - Running setup.py (path:/tmp/pip-ZSjERw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:58 INFO - Running setup.py (path:/tmp/pip-QshBC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:58 INFO - Running setup.py (path:/tmp/pip-UgNHvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:58 INFO - Running setup.py (path:/tmp/pip-AxDCpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:58 INFO - Running setup.py (path:/tmp/pip-tjpok6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:58 INFO - Running setup.py (path:/tmp/pip-RmV2DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:58 INFO - Running setup.py (path:/tmp/pip-EYo74T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:58 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)) 19:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:58 INFO - Running setup.py (path:/tmp/pip-X261th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:58 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)) 19:09:58 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)) 19:09:58 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)) 19:09:58 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)) 19:09:58 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)) 19:09:58 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)) 19:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:58 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 19:09:58 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 19:09:58 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 19:09:58 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 19:09:58 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 19:09:58 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 19:10:00 INFO - Downloading blessings-1.6.tar.gz 19:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:00 INFO - Installing collected packages: blessings 19:10:00 INFO - Running setup.py install for blessings 19:10:00 INFO - Successfully installed blessings 19:10:00 INFO - Cleaning up... 19:10:00 INFO - Return code: 0 19:10:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:00 INFO - Reading from file tmpfile_stdout 19:10:00 INFO - Current package versions: 19:10:00 INFO - argparse == 1.2.1 19:10:00 INFO - blessings == 1.6 19:10:00 INFO - blobuploader == 1.2.4 19:10:00 INFO - docopt == 0.6.1 19:10:00 INFO - functools32 == 3.2.3-2 19:10:00 INFO - jsonschema == 2.5.1 19:10:00 INFO - manifestparser == 1.1 19:10:00 INFO - mozInstall == 1.12 19:10:00 INFO - mozcrash == 0.17 19:10:00 INFO - mozdebug == 0.1 19:10:00 INFO - mozdevice == 0.48 19:10:00 INFO - mozfile == 1.2 19:10:00 INFO - mozhttpd == 0.7 19:10:00 INFO - mozinfo == 0.9 19:10:00 INFO - mozleak == 0.1 19:10:00 INFO - mozlog == 3.2 19:10:00 INFO - moznetwork == 0.27 19:10:00 INFO - mozprocess == 0.22 19:10:00 INFO - mozprofile == 0.28 19:10:00 INFO - mozrunner == 6.11 19:10:00 INFO - mozscreenshot == 0.1 19:10:00 INFO - mozsystemmonitor == 0.3 19:10:00 INFO - moztest == 0.7 19:10:00 INFO - mozversion == 1.4 19:10:00 INFO - psutil == 3.1.1 19:10:00 INFO - requests == 1.2.3 19:10:00 INFO - wsgiref == 0.1.2 19:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:00 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:10:00 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 19:10:00 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 19:10:00 INFO - Using env: {'DISPLAY': ':0', 19:10:00 INFO - 'HOME': '/home/cltbld', 19:10:00 INFO - 'LANG': 'en_US.UTF-8', 19:10:00 INFO - 'LANGUAGE': 'en_US:en', 19:10:00 INFO - 'LOGNAME': 'cltbld', 19:10:00 INFO - 'MAIL': '/var/mail/cltbld', 19:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:00 INFO - 'MOZ_NO_REMOTE': '1', 19:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:00 INFO - 'NO_EM_RESTART': '1', 19:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:00 INFO - 'PWD': '/builds/slave/test', 19:10:00 INFO - 'SHELL': '/bin/bash', 19:10:00 INFO - 'SHLVL': '1', 19:10:00 INFO - 'TERM': 'linux', 19:10:00 INFO - 'TMOUT': '86400', 19:10:00 INFO - 'USER': 'cltbld', 19:10:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:00 INFO - '_': '/tools/buildbot/bin/python'} 19:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 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)) 19:10:01 INFO - Cleaning up... 19:10:01 INFO - Return code: 0 19:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:01 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:10:01 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 19:10:01 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 19:10:01 INFO - Using env: {'DISPLAY': ':0', 19:10:01 INFO - 'HOME': '/home/cltbld', 19:10:01 INFO - 'LANG': 'en_US.UTF-8', 19:10:01 INFO - 'LANGUAGE': 'en_US:en', 19:10:01 INFO - 'LOGNAME': 'cltbld', 19:10:01 INFO - 'MAIL': '/var/mail/cltbld', 19:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:01 INFO - 'MOZ_NO_REMOTE': '1', 19:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:01 INFO - 'NO_EM_RESTART': '1', 19:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:01 INFO - 'PWD': '/builds/slave/test', 19:10:01 INFO - 'SHELL': '/bin/bash', 19:10:01 INFO - 'SHLVL': '1', 19:10:01 INFO - 'TERM': 'linux', 19:10:01 INFO - 'TMOUT': '86400', 19:10:01 INFO - 'USER': 'cltbld', 19:10:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:01 INFO - '_': '/tools/buildbot/bin/python'} 19:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:01 INFO - Cleaning up... 19:10:01 INFO - Return code: 0 19:10:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:01 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 0x7f9bd494bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', '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 19:10:01 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 19:10:01 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 19:10:01 INFO - Using env: {'DISPLAY': ':0', 19:10:01 INFO - 'HOME': '/home/cltbld', 19:10:01 INFO - 'LANG': 'en_US.UTF-8', 19:10:01 INFO - 'LANGUAGE': 'en_US:en', 19:10:01 INFO - 'LOGNAME': 'cltbld', 19:10:01 INFO - 'MAIL': '/var/mail/cltbld', 19:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:01 INFO - 'MOZ_NO_REMOTE': '1', 19:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:01 INFO - 'NO_EM_RESTART': '1', 19:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:01 INFO - 'PWD': '/builds/slave/test', 19:10:01 INFO - 'SHELL': '/bin/bash', 19:10:01 INFO - 'SHLVL': '1', 19:10:01 INFO - 'TERM': 'linux', 19:10:01 INFO - 'TMOUT': '86400', 19:10:01 INFO - 'USER': 'cltbld', 19:10:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:01 INFO - '_': '/tools/buildbot/bin/python'} 19:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:01 INFO - Downloading/unpacking flake8 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:10:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:10:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:04 INFO - no previously-included directories found matching 'docs/_build' 19:10:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:10:04 INFO - Running setup.py install for pep8 19:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:04 INFO - no previously-included directories found matching 'docs/_build' 19:10:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:10:04 INFO - Cleaning up... 19:10:04 INFO - Return code: 0 19:10:04 INFO - Running post-action listener: _resource_record_post_action 19:10:04 INFO - Running post-action listener: _start_resource_monitoring 19:10:04 INFO - Starting resource monitoring. 19:10:04 INFO - ##### 19:10:04 INFO - ##### Finished create-virtualenv step (success) 19:10:04 INFO - ##### 19:10:04 INFO - ##### 19:10:04 INFO - ##### Running install step. 19:10:04 INFO - ##### 19:10:04 INFO - Running pre-action listener: _resource_record_pre_action 19:10:04 INFO - Running main action method: install 19:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:04 INFO - Reading from file tmpfile_stdout 19:10:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:04 INFO - Reading from file tmpfile_stdout 19:10:04 INFO - Output received: 19:10:04 INFO - Usage: mozinstall [options] installer 19:10:04 INFO - Options: 19:10:04 INFO - -h, --help show this help message and exit 19:10:04 INFO - -d DEST, --destination=DEST 19:10:04 INFO - Directory to install application into. [default: 19:10:04 INFO - "/builds/slave/test"] 19:10:04 INFO - --app=APP Application being installed. [default: firefox] 19:10:04 INFO - mkdir: /builds/slave/test/build/application 19:10:04 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'] 19:10:04 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 19:10:21 INFO - Reading from file tmpfile_stdout 19:10:21 INFO - Output received: 19:10:21 INFO - /builds/slave/test/build/application/firefox/firefox 19:10:21 INFO - Running post-action listener: _resource_record_post_action 19:10:21 INFO - ##### 19:10:21 INFO - ##### Finished install step (success) 19:10:21 INFO - ##### 19:10:21 INFO - ##### 19:10:21 INFO - ##### Running run-tests step. 19:10:21 INFO - ##### 19:10:21 INFO - Running pre-action listener: _resource_record_pre_action 19:10:21 INFO - Running main action method: run_tests 19:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:21 INFO - Python 2.7.3 19:10:21 INFO - Return code: 0 19:10:21 INFO - grabbing minidump binary from tooltool 19:10:21 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')]} 19:10:21 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 0x19971c0>, '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 0x19980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:21 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 19:10:21 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 19:10:21 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 19:10:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:21 INFO - Return code: 0 19:10:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:10:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:10:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:22 INFO - Return code: 0 19:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:10:22 INFO - Using env: {'DISPLAY': ':0', 19:10:22 INFO - 'HOME': '/home/cltbld', 19:10:22 INFO - 'LANG': 'en_US.UTF-8', 19:10:22 INFO - 'LANGUAGE': 'en_US:en', 19:10:22 INFO - 'LOGNAME': 'cltbld', 19:10:22 INFO - 'MAIL': '/var/mail/cltbld', 19:10:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:22 INFO - 'MOZ_NO_REMOTE': '1', 19:10:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:22 INFO - 'NO_EM_RESTART': '1', 19:10:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:22 INFO - 'PWD': '/builds/slave/test', 19:10:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:22 INFO - 'SHELL': '/bin/bash', 19:10:22 INFO - 'SHLVL': '1', 19:10:22 INFO - 'TERM': 'linux', 19:10:22 INFO - 'TMOUT': '86400', 19:10:22 INFO - 'USER': 'cltbld', 19:10:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127', 19:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:22 INFO - '_': '/tools/buildbot/bin/python'} 19:10:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:10:22 INFO - mozversion application_buildid: 20160608163004 19:10:22 INFO - mozversion application_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 19:10:22 INFO - mozversion application_display_name: Nightly 19:10:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:22 INFO - mozversion application_name: Firefox 19:10:22 INFO - mozversion application_remotingname: firefox 19:10:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:10:22 INFO - mozversion application_vendor: Mozilla 19:10:22 INFO - mozversion application_version: 50.0a1 19:10:22 INFO - mozversion platform_buildid: 20160608163004 19:10:22 INFO - mozversion platform_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 19:10:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:10:22 INFO - mozversion platform_version: 50.0a1 19:10:22 INFO - using testdate: 1465438222 19:10:22 INFO - actual date: 1465438222 19:10:22 INFO - starting webserver on 'localhost:32940' 19:10:22 INFO - SUITE-START | Running 2 tests 19:10:22 INFO - TEST-START | dromaeo_css 19:10:22 INFO - operating with platform_type : linux_ 19:10:22 INFO - Initialising browser for dromaeo_css test... 19:10:22 INFO - TEST-INFO | started process 9260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpizeKx4/profile http://localhost:32940/getInfo.html) 19:10:29 INFO - PROCESS | 9260 | __metrics Screen width/height:1600/1200 19:10:29 INFO - PROCESS | 9260 | colorDepth:24 19:10:29 INFO - PROCESS | 9260 | Browser inner width/height: 1024/697 19:10:29 INFO - PROCESS | 9260 | __metrics 19:10:30 ERROR - PROCESS | 9260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:10:31 INFO - TEST-INFO | 9260: exit 0 19:10:31 INFO - Browser initialized. 19:10:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:31 INFO - TEST-INFO | started process 9384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpizeKx4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:43 INFO - PROCESS | 9384 | RSS: Main: 167485440 19:10:43 INFO - PROCESS | 9384 | 19:11:32 INFO - PROCESS | 9384 | 1465438292805 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] 19:13:40 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32940/tests/dromaeo/cssquery-ext.html) 19:13:41 INFO - PROCESS | 9384 | RSS: Main: 170819584 19:13:41 INFO - PROCESS | 9384 | 19:16:43 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-ext.html (next: http://localhost:32940/tests/dromaeo/cssquery-jquery.html) 19:16:43 INFO - PROCESS | 9384 | RSS: Main: 170471424 19:16:43 INFO - PROCESS | 9384 | 19:19:45 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32940/tests/dromaeo/cssquery-mootools.html) 19:19:46 INFO - PROCESS | 9384 | RSS: Main: 171503616 19:19:46 INFO - PROCESS | 9384 | 19:22:48 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32940/tests/dromaeo/cssquery-prototype.html) 19:22:48 INFO - PROCESS | 9384 | RSS: Main: 169082880 19:22:48 INFO - PROCESS | 9384 | 19:25:51 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32940/tests/dromaeo/cssquery-yui.html) 19:25:51 INFO - PROCESS | 9384 | RSS: Main: 171012096 19:25:51 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | Cycle 1(1): loaded http://localhost:32940/tests/dromaeo/cssquery-yui.html (next: http://localhost:32940/tests/dromaeo/cssquery-dojo.html) 19:28:54 INFO - PROCESS | 9384 | RSS: Main: 172482560 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | __start_tp_report 19:28:54 INFO - PROCESS | 9384 | _x_x_mozilla_page_load 19:28:54 INFO - PROCESS | 9384 | _x_x_mozilla_page_load_details 19:28:54 INFO - PROCESS | 9384 | |i|pagename|runs| 19:28:54 INFO - PROCESS | 9384 | |0;dojo.html;3134.7962382445126;3139.4192074466227;3153.62156541215;3158.88943886964;3166.0185342543828;5260.342457192851;5292.603054770893;5304.177852432874;5311;5325.440828712987;5245.344331958505;5332;5346.599005074616;5390.272313237711;5397.352317721869;4820.060088282787;4861.1492988727005;4940.728259945701;4985.326980857592;5028.446870844205;799.6166810650242;4765.475797662271;4834.516548345173;4867.050925069613;4927;4833.25084611884;4856.878578035559;4876.4148302203785;4885.5358740919555;4907.312976183337;4884.975575122137;4885.828995985124;4889.853304400838;4900.632452566037;4935.827246046371;4772.928406073877;4795.640326975491;4799.976000120012;4840.298156767284;4842.249451335014;5232.970612628293;5241.318628578299;5261.473852614746;5301.522862942354;5362.061639213122;5623.887522249573;5745.2243947067445;5760.481556659879;5765.1928729977835;5775.27809023872;5759.971200143972;5783.363829978699;5802.245708057925;5823.854403639901;5839.445252700986;5385.8114965976;5430.5927055471;5435.918461223085;5439.945600544023;5468.425815289377;5761.3950535194035;5842.006858834008;5893.587448878623;5937.970310148508;5950.523958083343;5663.943360566424;5721.485066344049;5726.599138060295;5729.255196824386;5773.566982476331;5798.304203495608;5800.941990580124;5806;5807.041838096667;5813.069908814569;5589.077802162597;5691.430856914276;5737.598368114275;5776;5786.768529258867;5758.74085666146;5781.103928891029;5794.971025144847;5804.970975145182;5841.182234487175;4378.16814805186;4405.581469760367;4415.845445409395;4419.889502762392;4437.955620443819;3857.1707082977296;3896.0259935016247;3934.803259836997;3940.389239667856;3954.189391174802;5355.464453554613;5425.484578964992;5455.809046683347;5471.398146203915;5503.394626591072;5797.652140871477;5803.506701930299;5826.79606213789;5828.679422631796;5829.09649004405;5358.490943360374;5388.3533975922355;5404.054290499147;5421.969825733098;5497.422770609109;4918.926216106761;4958.057968985881;4967.552920237196;4987.700737955734;4989.650724449326;5912.438318359749;5939.792107276225;5943.940560594425;5946;5952.255968003999;5644.548436125018;5763.9135412968;5777.653340799649;5787.305523337226;5790.913136302875;5917.023691091094;5967.433093856077;5984.102384642339;6000.039993601003;6026.638401695912;5723.370429252695;5730.255066841284;5733.31200255972;5735.082386818089;5739.799107031234;5716.256886604881;5769.74036168365;5830.854228644148;5842.1820945066875;5854.414558544111;5667.744951477111;5668.234788303526;5669.177969194526;5674.74463649145;5687.516561092188;5667.659940403589;5690.5163061140265;5693.9430605693415;5695.572832037697;5708.4862362387585;5436.728163591725;5519.282493276009;5526.336839579276;5575.135853942646;5596.796688711946;5632.859178520406;5657.745401456862;5670.234518339971;5674.631148975303;5679.659220446786;5570.24801651788;5573.749181286771;5574.08027675429;5592.105263157875;5598.496135347838 19:28:54 INFO - PROCESS | 9384 | |1;ext.html;581.6335708503644;599.8170557979814;620.0451304990314;645.0936434309793;645.3353046362246;43742;45306.773466132705;45419.31871021933;45473.77263113688;49318.50681493184;46825.53174468254;47213.7639311803;47279.76360118195;47564;47585.52414475854;8904.109589041109;8990.460572365646;9028.548572571344;9031.09689031095;9049.864252036225;8868.600912958933;8951.641934322652;9023.413478123934;9037.728868133967;9043.773905652346;9030.638774449015;9105.089491050909;9126.041765614615;9138.0405057469;9148.451092934445;8938.821223575525;9028.41315314509;9034.05142460042;9044.09559044097;9046.728598142066;8917.687880924137;8986.775330616721;9050.411723238034;9056.683016094405;9059.50172740499;43744.343834842504;43832.78083609593;43865.34201986973;44056.559434405564;44365.55634443647;3332.1169889979174;3464.1512829356716;3603.69368603669;3617.927641447183;3673.8530458781615;31006.379872402427;33098.50352244718;33764.6623533764;33791.662083379095;33842.153946151295;4260.10537787062;4321.675874309408;4354.54277300882;4489.775511224459;4491.73049617024;375950.12024939974;376059.99999999726;376116;378325;380940;62210.37789622046;62366.68816655887;62547.374526255066;62659.37340626626;62845.68577157085;64801.35198648048;65486.345136548975;65709.67145164244;65755.34244657587;65948.68102638016;17577.296908123786;17629.559261018578;18064.277428902697;18245.270189192284;18579.44261672152;13832.861671383158;14012.579622611338;14033.017688761689;14048.789268160986;14070.085444446078;20134.597308053755;20185;20197.394078177676;20226.47169103862;20260.89869550643;7045.225025247219;7316.414686825041;7398.667059982314;7442.18136005039;7468.21583733711;1054.3937236089125;1152.654203738875;1201.7536405036947;1203.4283715235192;1230.4647478346947;32307.192320191712;33278.66721332756;33718.831405842815;33879.49180762291;34304.65695343065;1105.3975583307117;1143.0798207442922;1143.1255089856268;1184.8163534652142;1207.269601890861;17350.557746032406;17605.64788704219;17649.205785739672;17700.29198832032;17881.821181788277;609545;610484;612964;615705;615830;60133.09800352998;60264.397356026755;60631.393686062576;60689;61037;1351.885089767361;1379.4344318829233;1415.978760318596;1425.5010746238734;1433.6917562723856;32083.679163208068;32914.67085329116;33039.50440743439;33159;33455;53940.730296348265;54088.45911540992;54112.45887541232;54444.18333725077;54499.455005451025;474451;478124;478368;478985;479154;28729;29115;29770.70229297679;29843.850780745957;29902;49893.00213995772;50479;51190;51688;52181;42369.36445953375;43567;43644.78177609092;43779;44128.33807492955;42035.15929681328;42054.15891682088;42776.77275709088;43119.56880431156;43179.78410107929;36569.08577285483;41293.58706412897;41582.584174159085;42162.36756448717;42239;35060.824695876356;37755.244895101394;37770.2445951074;38091.42862857115;38143.23713525658;28531.714682853737;28864.42271154607;28909.421811564072;29426.852865735535;29499 19:28:54 INFO - PROCESS | 9384 | |2;jquery.html;376.7569917403275;383.6317135549872;388.44258489068187;399.49663424085645;402.5692509015351;17332.393366232183;18946.62106757864;19767.110480028397;19886.60226795465;19962.30131945384;18224.27102915882;18585.256589736393;18798;18896.338628147983;18941.52646183846;5398.676079435227;5422.91865622016;5540.750666220009;5553.888922221553;5617.213590097369;5468.425815289397;5515.972420137894;5550.750216240279;5555.638883472561;5586.24585680934;5236;5496.0931446311315;5501.229827824108;5507.366652834915;5519.39286678465;5482.698451585161;5517.227588137664;5574.721263936827;5581.079121944895;5598.524125449342;5617.325920889479;5622.044252477048;5627.380988091307;5648.915266271009;5662.320521537442;18538.721919171225;21734;21978.670319945213;22570;22664;2031.7866624004562;2215.7784221577713;2219.223271854854;2431.7811396974357;2446.0949448704096;9649.807003859954;9793.262211680763;9801.901980980241;10067.798644027152;10072.94963525185;1837.2926423327115;1922.09661459114;1927.4795805132535;1929.4018854155256;1973.851961102923;72603.63698181475;76788.61605691936;78582.60708696477;78819.6059019707;79060.60469697672;10575;10607.257491975488;10896.237263391486;11102.111831053497;11135.443227838576;15170.31733571992;15365.462208822637;15374.769378459332;15387.076775393512;15437.84562154364;8268.710595129141;8333.541655208901;8495.980482342158;8546.102659220816;8624.878765760412;7515.210902855121;7633.503822251647;7719.189485104095;7720.922790772132;8254.42219044661;4682;4746.359241502353;4789.3294938708605;4807.543283388072;4822.590079843182;1979.1984246380239;1990.9701354479694;1998.7701414337537;2000.109951071759;2053.435305291027;899.7210864631985;972.1979367022235;978.2907392140642;1037.6005237983431;1056.9207309451822;18293.81706182948;18624.255029798656;18718.71921921172;18793.248270069318;18901.81098189028;996.940183588987;1014.1633152649094;1025.3130402630256;1028.4189432970347;1080.6649938519083;10077.29458937882;10585.523651435704;10625.043746062891;10671.626493072705;10699.411532365795;463213;463902;471229;480625;483723;72438;78970;83690;90173.54913225523;92831.53584232036;1021.8211812932707;1026.6899476178598;1038.1227862456212;1066.5627092891878;1075.188232884183;16776.748348774534;16827.831721682625;17272.568185795455;17415.47753567395;17641.735373969143;28723.712762872103;29323.560146597392;40561.79719101386;41137.58862411338;41970.37044444397;51718.74140629273;51953.740231300115;54407.45592544024;60213;60902.69548652229;8137.145599712182;8539.65589592937;8669.91330086691;8717.389782715403;8797.692080777142;11893.643190703946;12850.742985140057;12993.155444896052;13073.411696473871;13139.671508212372;11681.415929203677;11714.531418743496;11723.237989530653;11725.296482211095;11996.880031199576;10999.120070394189;11785.292882427082;11864.703382415508;11926.344051077274;11959.461824217757;11733.706657333294;11942.40879401014;11966.58116965902;12227.205231659913;12350;8492.363072769444;8514.70198543048;8528;8594.527300998256;8656.091110433314;11332.320060796048;11879.287242765462;11885.762284754084;11936.880631193577;12129.090318225992 19:28:54 INFO - PROCESS | 9384 | |3;mootools.html;1482.2144263540324;1482.725695746287;1613.9677206455872;1756.7364895265716;1758.8504977076957;7146.96426517868;8061.113277539466;8182.2226888445575;8732.694355697551;8744.387892847502;8264.173582641733;8508.234258916696;8529;8553.871691924625;8583.570821458918;2182.138055468089;2206.249875042485;2217.4899773052207;2219.034719896842;2222.355516900105;2213.3359992002415;2229.554089182162;2269.818414526842;2272.8068114210314;2282.988585057072;2210.2816584609986;2221.133757834438;2229.1194977983687;2235.9888200558976;2252.3355610094977;2163.167180635451;2167.8807665578465;2173;2180.1061564758375;2185.6065908136607;2150.086213359316;2157;2159.5464952359866;2159.546495236002;2169.0673010605433;8463.195996380335;8480.66077356905;8508.78728031798;8514.318854491688;8534.829303413959;4910.508949105097;5006.424261209971;5006.774695138727;5007.198848184273;5016.347874776292;3017.8943736969322;3091.6753740857334;3105.394448082625;3119.625644922624;3127.061881435583;1094.1574987259844;1103.2112039891435;1133;1137.744007598292;1147.5295128997154;11347.489362978686;11463.999999999916;11466.598669046543;11469.88530114705;11478.081753459786;4264.722793018444;4312.633426158749;4351.173277077345;4374.147041326911;4428.689991700615;9728.75678108053;9730.854037189449;9747.902520974842;9753.609855605697;9754.122129008423;4906.975465122651;4976.278439626234;4988.301637770715;4988.72562009093;5029.094762942632;4000.4599379084034;4444.11117776446;4581.748003859753;4590.793414296365;4596.839110631112;3748.625137486284;3758.680512156497;3810.123671555558;3821.980890095532;3936.3111455495173;1140.9543618255177;1142.9142814288962;1158.7624536969902;1159.565163063851;1185.8399116119385;894.5437826708426;926.8841394825647;966.6375109334;967.9322447428613;1005.3465247588979;5676.318841739017;5776.42235776419;5820.563457740686;6049.848753781191;6057.515398768088;965.6620182935916;969.8351280282228;980.6028558433845;1003.3678782367062;1047.1884289675563;4126.968257935516;4136.296829538986;4168.270552653274;4212.410262563182;4214.936775948363;10096.798064038825;10300.536475858604;10464.476776161313;10486.161107111566;10487.895121048692;10273.383596984206;10327.586896524055;10343.27597068213;10375.533101010473;10378.06597406237;7482.214367491444;7718.884216736641;7760.456768026297;7896.881546776803;7972.123066462685;5864.882702346014;5979.073243647242;5999.850003749942;6045.969770151121;6119.44924956756;8938.955305223431;9278;9282.489463079595;9378.343515953818;9468.905310946802;9327.906720932975;9499.050094990445;9585;9612.807743845224;9614.278929080487;7293.307135822089;7326.084239470067;7335.266473352622;7369.189389167294;7392.4825262231125;7594.278543538355;7608.885866711893;7635;7647.470505898954;7742.729004484816;7061.788146355618;7266.818329541804;7306.525075870051;7348.191698913222;7363.77908662741;7072.009918611501;7088.113985751781;7118.110236220473;7210.351068403869;7300.16048154469;6764.526483146329;6769.526133170828;6780.966095169492;6837.829054273484;6842.623655698984;4745.477997420212;4878.438979517401;4945.703257804544;5071.847844564669;5157.510036546522;5019.648624596243;5087.084324821568;5099.260607212008;5112.488751125006;5155.742212889416 19:28:54 INFO - PROCESS | 9384 | |4;prototype.html;317.5250959294079;325.3590426859088;330.97848639838423;331.4828866967531;331.6534221738284;5486.231927530149;5529.364123125842;5674.375818659944;5708.944779879245;5759.39526349733;5568.52667523261;5571.415001424853;5594.328680558328;5644.181593668915;5644.8306550803545;4385.758783266919;4390.84632037878;4402.823887044515;4416.22716024696;4416.955830441702;4141;4336.024394511242;4337.436133302666;4423.159599676052;4451.955480445203;4293.248681480744;4304.935425968613;4311.331743579734;4312.482502099752;4355.738655680653;4276.379924910871;4316.6762492813;4319.33050377192;4326.459192600925;4350.782460876975;3699.3896007158787;3737.757045792042;3782.583915769263;3790.753601015925;3802.1445174835717;5306.7611957462;5333.546648534879;5349.545288650469;5350.732463376816;5400.810971616014;4871.634627402959;4962.6526143169995;4963.652544321899;4984.227444746034;4993.926305844225;5628.296462942132;5839.737211825478;5889.440503152194;5922;5937.67342796146;4138.544760076389;4165.271077561415;4172.144710334374;4182.1008483176265;4184.163167366509;6045.851288255218;6110.9611366067875;6163.414475624809;6170.81487555374;6182.938170618326;4126.3397856343445;4176.352665336817;4197.601227883346;4228.788560571959;4238.173556156582;4230.090530535888;4233.809478573472;4233.91532169361;4239.851605193865;4240.279152544075;4869.415670119608;4908.386451693538;4919.483454237254;4922.950770492249;4956.628252881048;5707.315122185364;5873.383294754075;5889;5894.2926848778425;5905.228431470542;1466.7213229486363;1469.419579266184;1473.9631509212356;1478.9186594737178;1491.2394678713717;918.4334425785785;927.4806108579218;931.38993958957;942.4345392764286;947.393668052447;5041.42023667283;5067.239914012927;5088.5420312171345;5139.0471620783865;5143.228515722597;5393.568514518829;5397.568194544427;5431.918521222185;5454.91817622736;5467.17992301158;4848.466668666444;5025.623078269145;5040.79021034949;5049.722265275445;5059.241113832881;2885.264257614295;2896.319364949235;2942.3379739558854;2943.955840662392;2949.513330300519;5518.179000929684;5548.6960564267365;5561.638493497991;5592.245046918695;5603.271574695264;5328.600354973392;5422.972885135549;5475.534579560782;5494.36814766299;5495.587830912617;5521.861953451196;5573.944260557424;5574.2719756875495;5607.186957891165;5625.324961004788;5238.76425560843;5438.776275338176;5484.369297530835;5490.258815060076;5520.696361699985;5310.761015754378;5389.197617238935;5470.17947307907;5476.658218736435;5506.733451306142;5612.01789686795;5654.208410822406;5658.81164955364;5699;6012.218411606463;4179.895502612459;4230.027093768389;4236.6187043166265;4238.088810905547;4252.617264446215;6056.182415373868;6065.848353791191;6076.787312444043;6096.878062438637;6099.4510494053975;5675.858103547444;5839.591228613956;5848.385919478394;5898;5903;5845.152452894392;5847.093700476433;5856.238688970407;5869.148973398918;5870.911936320873;5738.971305143447;5770.192173095854;5809.779946211343;5825.76696932118;5830.7959221427045;5749.712514374348;5920;5978.312494063064;6027.939720602913;6036.486898613667;5897.882042359043;5924.6149000314845;5932.9703351484695;5951.315598706205;5954.434328738763 19:28:54 INFO - PROCESS | 9384 | |5;yui.html;734.1483878700708;765.2462324610258;772.2007722007723;786.5162924801247;801.5311043039821;14505.274736263184;14541.345639446225;14730.852691473083;14893.180875051868;14919.627009324759;13681.589552313446;13713.794293085612;13714.931425342884;13777.586672399844;13786.241756703377;673.7069374821943;785.9135495095535;799.73608709126;810.0360570920585;811.4847072109224;805.0701439836997;805.730080423056;809.295912556077;812.6749300279877;817.81190326225;874.8337815815007;877.4165180155189;878.1613559051091;878.569500944539;878.9165029322204;863.896332440105;867.4665080975186;870.525563567857;873.4060838629729;874.9168828961239;632.3992207402986;635.3075148088606;636.2174525333866;637.1939496536885;637.8851806674796;12906.67733306675;12965;12976.091673582852;12979.286139262336;12989.025823063308;14615.12309261437;14715.852841471555;15391.307391167424;15465.304061317267;15738.606534836606;12052.337121458317;12081.45633446497;12172.939135304267;12432.502699891993;12522;3797.544294684628;3799.1831756172555;3813.6186381361917;3831.4252862070634;3962.960370396288;74996.62501687456;75973.62013189899;76695.61652191704;76805;76858.23141768623;10869.945650271698;11136;11232.775344493064;11385.203035787416;11444.427778611036;22907.541849163255;22935.770642293362;22938.65592016121;22947.311580652608;22991;7949.801254968672;8081.111077781439;8210;8431.19903609156;8494;4392.604665580113;4597.402337696078;4656.627469802408;4724.952750472451;4804.519548045238;3154.14837993745;3273.4762438009802;3287.4904389819617;3291.8683252670103;3305;571.7998700454891;577.0795581048221;580.5587753307432;581.5899790647584;582.0512564519805;666.7366390275814;675.7094449386713;692.3491917597443;700.6531766775479;741.3698356397019;9275.871131541347;9580.904190958001;10028.387838313172;10057.273200604848;10124.392536447836;582.3564960718345;694.4097517110416;701.9859602807916;702.220535205921;732.8607564562716;4496.213162696515;4677.766111694402;4723.149833030087;4754.477007529169;4759.452662943737;102366.48816755868;102999.48500257601;103495.4825225869;105065;106509.46745266224;89070;90105;90326;90673;90725.54637226903;78918.60540697374;79133.20866791373;79671.20328796637;80133.59933200413;80505.19494805094;8311.584420779058;8349.039860415887;8368.250749295381;8519.787005324917;8683.175098365646;43154.352684710386;50031.749206270135;50637.746811267185;50981.23528147155;51152.48847511477;64719.35280647133;66004.33995659983;71176;73305.13558915381;74768.62615687105;11033.393163376091;11046.558137674725;11092.611758588733;11366.943165284121;11847.526098955945;12420.378981051092;12832.101752877208;12944.741105178033;13045.673858153623;13059.608211753663;11947.223430476992;12054.879451205376;12309.44607492683;12675.492980280686;13006.544770932973;11883;11892.286462812259;12135.635930922086;12169.20900141488;12432.067594930597;11440.084793216689;11862.762744745229;11874.719465363116;11937.224080435091;12239.75520489603;10246.38521688701;10381.896181038395;10955.287906286067;11210.66368008961;11258.718532036764;10338.793224135325;10964.451777411257;11038;11167.888321116685;11288.2662626929 19:28:54 INFO - PROCESS | 9384 | __end_tp_report 19:28:54 INFO - PROCESS | 9384 | __start_cc_report 19:28:54 INFO - PROCESS | 9384 | _x_x_mozilla_cycle_collect,364 19:28:54 INFO - PROCESS | 9384 | __end_cc_report 19:28:54 INFO - PROCESS | 9384 | __startTimestamp1465439334846__endTimestamp 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | ------- Summary: start ------- 19:28:54 INFO - PROCESS | 9384 | Number of tests: 6 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#0] dojo.html Cycles:165 Average:5327.77 Median:5592.11 stddev:707.46 (12.7%) stddev-sans-first:688.39 19:28:54 INFO - PROCESS | 9384 | Values: 3134.8 3139.4 3153.6 3158.9 3166.0 5260.3 5292.6 5304.2 5311.0 5325.4 5245.3 5332.0 5346.6 5390.3 5397.4 4820.1 4861.1 4940.7 4985.3 5028.4 799.6 4765.5 4834.5 4867.1 4927.0 4833.3 4856.9 4876.4 4885.5 4907.3 4885.0 4885.8 4889.9 4900.6 4935.8 4772.9 4795.6 4800.0 4840.3 4842.2 5233.0 5241.3 5261.5 5301.5 5362.1 5623.9 5745.2 5760.5 5765.2 5775.3 5760.0 5783.4 5802.2 5823.9 5839.4 5385.8 5430.6 5435.9 5439.9 5468.4 5761.4 5842.0 5893.6 5938.0 5950.5 5663.9 5721.5 5726.6 5729.3 5773.6 5798.3 5800.9 5806.0 5807.0 5813.1 5589.1 5691.4 5737.6 5776.0 5786.8 5758.7 5781.1 5795.0 5805.0 5841.2 4378.2 4405.6 4415.8 4419.9 4438.0 3857.2 3896.0 3934.8 3940.4 3954.2 5355.5 5425.5 5455.8 5471.4 5503.4 5797.7 5803.5 5826.8 5828.7 5829.1 5358.5 5388.4 5404.1 5422.0 5497.4 4918.9 4958.1 4967.6 4987.7 4989.7 5912.4 5939.8 5943.9 5946.0 5952.3 5644.5 5763.9 5777.7 5787.3 5790.9 5917.0 5967.4 5984.1 6000.0 6026.6 5723.4 5730.3 5733.3 5735.1 5739.8 5716.3 5769.7 5830.9 5842.2 5854.4 5667.7 5668.2 5669.2 5674.7 5687.5 5667.7 5690.5 5693.9 5695.6 5708.5 5436.7 5519.3 5526.3 5575.1 5596.8 5632.9 5657.7 5670.2 5674.6 5679.7 5570.2 5573.7 5574.1 5592.1 5598.5 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#1] ext.html Cycles:180 Average:65448.25 Median:43693.39 stddev:132602.55 (303.5%) stddev-sans-first:132885.10 19:28:54 INFO - PROCESS | 9384 | Values: 581.6 599.8 620.0 645.1 645.3 43742.0 45306.8 45419.3 45473.8 49318.5 46825.5 47213.8 47279.8 47564.0 47585.5 8904.1 8990.5 9028.5 9031.1 9049.9 8868.6 8951.6 9023.4 9037.7 9043.8 9030.6 9105.1 9126.0 9138.0 9148.5 8938.8 9028.4 9034.1 9044.1 9046.7 8917.7 8986.8 9050.4 9056.7 9059.5 43744.3 43832.8 43865.3 44056.6 44365.6 3332.1 3464.2 3603.7 3617.9 3673.9 31006.4 33098.5 33764.7 33791.7 33842.2 4260.1 4321.7 4354.5 4489.8 4491.7 375950.1 376060.0 376116.0 378325.0 380940.0 62210.4 62366.7 62547.4 62659.4 62845.7 64801.4 65486.3 65709.7 65755.3 65948.7 17577.3 17629.6 18064.3 18245.3 18579.4 13832.9 14012.6 14033.0 14048.8 14070.1 20134.6 20185.0 20197.4 20226.5 20260.9 7045.2 7316.4 7398.7 7442.2 7468.2 1054.4 1152.7 1201.8 1203.4 1230.5 32307.2 33278.7 33718.8 33879.5 34304.7 1105.4 1143.1 1143.1 1184.8 1207.3 17350.6 17605.6 17649.2 17700.3 17881.8 609545.0 610484.0 612964.0 615705.0 615830.0 60133.1 60264.4 60631.4 60689.0 61037.0 1351.9 1379.4 1416.0 1425.5 1433.7 32083.7 32914.7 33039.5 33159.0 33455.0 53940.7 54088.5 54112.5 54444.2 54499.5 474451.0 478124.0 478368.0 478985.0 479154.0 28729.0 29115.0 29770.7 29843.9 29902.0 49893.0 50479.0 51190.0 51688.0 52181.0 42369.4 43567.0 43644.8 43779.0 44128.3 42035.2 42054.2 42776.8 43119.6 43179.8 36569.1 41293.6 41582.6 42162.4 42239.0 35060.8 37755.2 37770.2 38091.4 38143.2 28531.7 28864.4 28909.4 29426.9 29499.0 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#2] jquery.html Cycles:180 Average:27859.44 Median:12547.89 stddev:77766.54 (619.8%) stddev-sans-first:77957.32 19:28:54 INFO - PROCESS | 9384 | Values: 376.8 383.6 388.4 399.5 402.6 17332.4 18946.6 19767.1 19886.6 19962.3 18224.3 18585.3 18798.0 18896.3 18941.5 5398.7 5422.9 5540.8 5553.9 5617.2 5468.4 5516.0 5550.8 5555.6 5586.2 5236.0 5496.1 5501.2 5507.4 5519.4 5482.7 5517.2 5574.7 5581.1 5598.5 5617.3 5622.0 5627.4 5648.9 5662.3 18538.7 21734.0 21978.7 22570.0 22664.0 2031.8 2215.8 2219.2 2431.8 2446.1 9649.8 9793.3 9801.9 10067.8 10072.9 1837.3 1922.1 1927.5 1929.4 1973.9 72603.6 76788.6 78582.6 78819.6 79060.6 10575.0 10607.3 10896.2 11102.1 11135.4 15170.3 15365.5 15374.8 15387.1 15437.8 8268.7 8333.5 8496.0 8546.1 8624.9 7515.2 7633.5 7719.2 7720.9 8254.4 4682.0 4746.4 4789.3 4807.5 4822.6 1979.2 1991.0 1998.8 2000.1 2053.4 899.7 972.2 978.3 1037.6 1056.9 18293.8 18624.3 18718.7 18793.2 18901.8 996.9 1014.2 1025.3 1028.4 1080.7 10077.3 10585.5 10625.0 10671.6 10699.4 463213.0 463902.0 471229.0 480625.0 483723.0 72438.0 78970.0 83690.0 90173.5 92831.5 1021.8 1026.7 1038.1 1066.6 1075.2 16776.7 16827.8 17272.6 17415.5 17641.7 28723.7 29323.6 40561.8 41137.6 41970.4 51718.7 51953.7 54407.5 60213.0 60902.7 8137.1 8539.7 8669.9 8717.4 8797.7 11893.6 12850.7 12993.2 13073.4 13139.7 11681.4 11714.5 11723.2 11725.3 11996.9 10999.1 11785.3 11864.7 11926.3 11959.5 11733.7 11942.4 11966.6 12227.2 12350.0 8492.4 8514.7 8528.0 8594.5 8656.1 11332.3 11879.3 11885.8 11936.9 12129.1 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#3] mootools.html Cycles:180 Average:5513.18 Median:4997.57 stddev:3081.15 (61.7%) stddev-sans-first:3074.90 19:28:54 INFO - PROCESS | 9384 | Values: 1482.2 1482.7 1614.0 1756.7 1758.9 7147.0 8061.1 8182.2 8732.7 8744.4 8264.2 8508.2 8529.0 8553.9 8583.6 2182.1 2206.2 2217.5 2219.0 2222.4 2213.3 2229.6 2269.8 2272.8 2283.0 2210.3 2221.1 2229.1 2236.0 2252.3 2163.2 2167.9 2173.0 2180.1 2185.6 2150.1 2157.0 2159.5 2159.5 2169.1 8463.2 8480.7 8508.8 8514.3 8534.8 4910.5 5006.4 5006.8 5007.2 5016.3 3017.9 3091.7 3105.4 3119.6 3127.1 1094.2 1103.2 1133.0 1137.7 1147.5 11347.5 11464.0 11466.6 11469.9 11478.1 4264.7 4312.6 4351.2 4374.1 4428.7 9728.8 9730.9 9747.9 9753.6 9754.1 4907.0 4976.3 4988.3 4988.7 5029.1 4000.5 4444.1 4581.7 4590.8 4596.8 3748.6 3758.7 3810.1 3822.0 3936.3 1141.0 1142.9 1158.8 1159.6 1185.8 894.5 926.9 966.6 967.9 1005.3 5676.3 5776.4 5820.6 6049.8 6057.5 965.7 969.8 980.6 1003.4 1047.2 4127.0 4136.3 4168.3 4212.4 4214.9 10096.8 10300.5 10464.5 10486.2 10487.9 10273.4 10327.6 10343.3 10375.5 10378.1 7482.2 7718.9 7760.5 7896.9 7972.1 5864.9 5979.1 5999.9 6046.0 6119.4 8939.0 9278.0 9282.5 9378.3 9468.9 9327.9 9499.1 9585.0 9612.8 9614.3 7293.3 7326.1 7335.3 7369.2 7392.5 7594.3 7608.9 7635.0 7647.5 7742.7 7061.8 7266.8 7306.5 7348.2 7363.8 7072.0 7088.1 7118.1 7210.4 7300.2 6764.5 6769.5 6781.0 6837.8 6842.6 4745.5 4878.4 4945.7 5071.8 5157.5 5019.6 5087.1 5099.3 5112.5 5155.7 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#4] prototype.html Cycles:180 Average:4779.43 Median:5411.89 stddev:1396.46 (25.8%) stddev-sans-first:1359.63 19:28:54 INFO - PROCESS | 9384 | Values: 317.5 325.4 331.0 331.5 331.7 5486.2 5529.4 5674.4 5708.9 5759.4 5568.5 5571.4 5594.3 5644.2 5644.8 4385.8 4390.8 4402.8 4416.2 4417.0 4141.0 4336.0 4337.4 4423.2 4452.0 4293.2 4304.9 4311.3 4312.5 4355.7 4276.4 4316.7 4319.3 4326.5 4350.8 3699.4 3737.8 3782.6 3790.8 3802.1 5306.8 5333.5 5349.5 5350.7 5400.8 4871.6 4962.7 4963.7 4984.2 4993.9 5628.3 5839.7 5889.4 5922.0 5937.7 4138.5 4165.3 4172.1 4182.1 4184.2 6045.9 6111.0 6163.4 6170.8 6182.9 4126.3 4176.4 4197.6 4228.8 4238.2 4230.1 4233.8 4233.9 4239.9 4240.3 4869.4 4908.4 4919.5 4923.0 4956.6 5707.3 5873.4 5889.0 5894.3 5905.2 1466.7 1469.4 1474.0 1478.9 1491.2 918.4 927.5 931.4 942.4 947.4 5041.4 5067.2 5088.5 5139.0 5143.2 5393.6 5397.6 5431.9 5454.9 5467.2 4848.5 5025.6 5040.8 5049.7 5059.2 2885.3 2896.3 2942.3 2944.0 2949.5 5518.2 5548.7 5561.6 5592.2 5603.3 5328.6 5423.0 5475.5 5494.4 5495.6 5521.9 5573.9 5574.3 5607.2 5625.3 5238.8 5438.8 5484.4 5490.3 5520.7 5310.8 5389.2 5470.2 5476.7 5506.7 5612.0 5654.2 5658.8 5699.0 6012.2 4179.9 4230.0 4236.6 4238.1 4252.6 6056.2 6065.8 6076.8 6096.9 6099.5 5675.9 5839.6 5848.4 5898.0 5903.0 5845.2 5847.1 5856.2 5869.1 5870.9 5739.0 5770.2 5809.8 5825.8 5830.8 5749.7 5920.0 5978.3 6027.9 6036.5 5897.9 5924.6 5933.0 5951.3 5954.4 19:28:54 INFO - PROCESS | 9384 | 19:28:54 INFO - PROCESS | 9384 | [#5] yui.html Cycles:180 Average:19563.75 Median:4546.81 stddev:27759.46 (610.5%) stddev-sans-first:27801.33 19:28:54 INFO - PROCESS | 9384 | Values: 734.1 765.2 772.2 786.5 801.5 14505.3 14541.3 14730.9 14893.2 14919.6 13681.6 13713.8 13714.9 13777.6 13786.2 673.7 785.9 799.7 810.0 811.5 805.1 805.7 809.3 812.7 817.8 874.8 877.4 878.2 878.6 878.9 863.9 867.5 870.5 873.4 874.9 632.4 635.3 636.2 637.2 637.9 12906.7 12965.0 12976.1 12979.3 12989.0 14615.1 14715.9 15391.3 15465.3 15738.6 12052.3 12081.5 12172.9 12432.5 12522.0 3797.5 3799.2 3813.6 3831.4 3963.0 74996.6 75973.6 76695.6 76805.0 76858.2 10869.9 11136.0 11232.8 11385.2 11444.4 22907.5 22935.8 22938.7 22947.3 22991.0 7949.8 8081.1 8210.0 8431.2 8494.0 4392.6 4597.4 4656.6 4725.0 4804.5 3154.1 3273.5 3287.5 3291.9 3305.0 571.8 577.1 580.6 581.6 582.1 666.7 675.7 692.3 700.7 741.4 9275.9 9580.9 10028.4 10057.3 10124.4 582.4 694.4 702.0 702.2 732.9 4496.2 4677.8 4723.1 4754.5 4759.5 102366.5 102999.5 103495.5 105065.0 106509.5 89070.0 90105.0 90326.0 90673.0 90725.5 78918.6 79133.2 79671.2 80133.6 80505.2 8311.6 8349.0 8368.3 8519.8 8683.2 43154.4 50031.7 50637.7 50981.2 51152.5 64719.4 66004.3 71176.0 73305.1 74768.6 11033.4 11046.6 11092.6 11366.9 11847.5 12420.4 12832.1 12944.7 13045.7 13059.6 11947.2 12054.9 12309.4 12675.5 13006.5 11883.0 11892.3 12135.6 12169.2 12432.1 11440.1 11862.8 11874.7 11937.2 12239.8 10246.4 10381.9 10955.3 11210.7 11258.7 10338.8 10964.5 11038.0 11167.9 11288.3 19:28:54 INFO - PROCESS | 9384 | -------- Summary: end -------- 19:28:54 INFO - PROCESS | 9384 | 19:28:55 INFO - TEST-INFO | 9384: exit 0 19:28:55 INFO - TEST-OK | dromaeo_css | took 1112859ms 19:28:55 INFO - TEST-START | kraken 19:28:55 INFO - operating with platform_type : linux_ 19:28:55 INFO - Initialising browser for kraken test... 19:28:55 INFO - TEST-INFO | started process 9624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ovnRg/profile http://localhost:32940/getInfo.html) 19:29:01 INFO - PROCESS | 9624 | __metrics Screen width/height:1600/1200 19:29:01 INFO - PROCESS | 9624 | colorDepth:24 19:29:01 INFO - PROCESS | 9624 | Browser inner width/height: 1024/697 19:29:01 INFO - PROCESS | 9624 | __metrics 19:29:02 ERROR - PROCESS | 9624 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:29:03 INFO - TEST-INFO | 9624: exit 0 19:29:03 INFO - Browser initialized. 19:29:03 INFO - Running cycle 1/1 for kraken test... 19:29:03 INFO - TEST-INFO | started process 9743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ovnRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:15 INFO - PROCESS | 9743 | RSS: Main: 167350272 19:29:15 INFO - PROCESS | 9743 | 19:29:17 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32940/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:18 INFO - PROCESS | 9743 | RSS: Main: 172277760 19:29:18 INFO - PROCESS | 9743 | 19:29:21 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32940/tests/kraken/driver.html?testName=audio-dft) 19:29:21 INFO - PROCESS | 9743 | RSS: Main: 171831296 19:29:21 INFO - PROCESS | 9743 | 19:29:24 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32940/tests/kraken/driver.html?testName=audio-fft) 19:29:25 INFO - PROCESS | 9743 | RSS: Main: 166498304 19:29:25 INFO - PROCESS | 9743 | 19:29:27 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32940/tests/kraken/driver.html?testName=audio-oscillator) 19:29:28 INFO - PROCESS | 9743 | RSS: Main: 166875136 19:29:28 INFO - PROCESS | 9743 | 19:29:30 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32940/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:30 INFO - PROCESS | 9743 | RSS: Main: 167419904 19:29:30 INFO - PROCESS | 9743 | 19:29:33 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32940/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:34 INFO - PROCESS | 9743 | RSS: Main: 167600128 19:29:34 INFO - PROCESS | 9743 | 19:29:38 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32940/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:38 INFO - PROCESS | 9743 | RSS: Main: 165474304 19:29:38 INFO - PROCESS | 9743 | 19:29:41 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32940/tests/kraken/driver.html?testName=json-parse-financial) 19:29:42 INFO - PROCESS | 9743 | RSS: Main: 167165952 19:29:42 INFO - PROCESS | 9743 | 19:29:43 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32940/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:44 INFO - PROCESS | 9743 | RSS: Main: 167796736 19:29:44 INFO - PROCESS | 9743 | 19:29:46 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:46 INFO - PROCESS | 9743 | RSS: Main: 167563264 19:29:46 INFO - PROCESS | 9743 | 19:29:48 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:29:49 INFO - PROCESS | 9743 | RSS: Main: 167960576 19:29:49 INFO - PROCESS | 9743 | 19:29:52 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:52 INFO - PROCESS | 9743 | RSS: Main: 168075264 19:29:52 INFO - PROCESS | 9743 | 19:29:55 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:56 INFO - PROCESS | 9743 | RSS: Main: 167706624 19:29:56 INFO - PROCESS | 9743 | 19:29:57 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:32940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32940/tests/kraken/driver.html?testName=ai-astar) 19:29:58 INFO - PROCESS | 9743 | RSS: Main: 169013248 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | __start_tp_report 19:29:58 INFO - PROCESS | 9743 | _x_x_mozilla_page_load 19:29:58 INFO - PROCESS | 9743 | _x_x_mozilla_page_load_details 19:29:58 INFO - PROCESS | 9743 | |i|pagename|runs| 19:29:58 INFO - PROCESS | 9743 | |0;ai-astar;110;107;111;111;111;112;111;110;111;111 19:29:58 INFO - PROCESS | 9743 | |1;audio-beat-detection;157;124;156;177;126;163;165;129;178;132 19:29:58 INFO - PROCESS | 9743 | |2;audio-dft;162;161;161;161;160;163;176;161;162;162 19:29:58 INFO - PROCESS | 9743 | |3;audio-fft;75;75;75;161;77;75;76;75;159;76 19:29:58 INFO - PROCESS | 9743 | |4;audio-oscillator;86;85;152;86;85;89;150;86;86;152 19:29:58 INFO - PROCESS | 9743 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 19:29:58 INFO - PROCESS | 9743 | |6;imaging-darkroom;147;147;148;148;147;147;146;147;147;149 19:29:58 INFO - PROCESS | 9743 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;96;96 19:29:58 INFO - PROCESS | 9743 | |8;json-parse-financial;57;55;58;55;56;55;56;55;57;56 19:29:58 INFO - PROCESS | 9743 | |9;json-stringify-tinderbox;62;62;61;62;63;63;62;64;63;62 19:29:58 INFO - PROCESS | 9743 | |10;stanford-crypto-aes;80;80;79;83;82;81;81;83;122;79 19:29:58 INFO - PROCESS | 9743 | |11;stanford-crypto-ccm;130;123;143;132;121;143;126;135;128;123 19:29:58 INFO - PROCESS | 9743 | |12;stanford-crypto-pbkdf2;161;165;168;164;158;159;167;160;157;159 19:29:58 INFO - PROCESS | 9743 | |13;stanford-crypto-sha256-iterative;65;67;63;65;66;64;63;62;63;64 19:29:58 INFO - PROCESS | 9743 | __end_tp_report 19:29:58 INFO - PROCESS | 9743 | __start_cc_report 19:29:58 INFO - PROCESS | 9743 | _x_x_mozilla_cycle_collect,875 19:29:58 INFO - PROCESS | 9743 | __end_cc_report 19:29:58 INFO - PROCESS | 9743 | __startTimestamp1465439398053__endTimestamp 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | ------- Summary: start ------- 19:29:58 INFO - PROCESS | 9743 | Number of tests: 14 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 19:29:58 INFO - PROCESS | 9743 | Values: 110.0 107.0 111.0 111.0 111.0 112.0 111.0 110.0 111.0 111.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:160.00 stddev:21.09 (13.2%) stddev-sans-first:22.25 19:29:58 INFO - PROCESS | 9743 | Values: 157.0 124.0 156.0 177.0 126.0 163.0 165.0 129.0 178.0 132.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:4.68 (2.9%) stddev-sans-first:4.95 19:29:58 INFO - PROCESS | 9743 | Values: 162.0 161.0 161.0 161.0 160.0 163.0 176.0 161.0 162.0 162.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:35.64 (47.5%) stddev-sans-first:37.24 19:29:58 INFO - PROCESS | 9743 | Values: 75.0 75.0 75.0 161.0 77.0 75.0 76.0 75.0 159.0 76.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:86.00 stddev:31.51 (36.6%) stddev-sans-first:32.61 19:29:58 INFO - PROCESS | 9743 | Values: 86.0 85.0 152.0 86.0 85.0 89.0 150.0 86.0 86.0 152.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:29:58 INFO - PROCESS | 9743 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 19:29:58 INFO - PROCESS | 9743 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 146.0 147.0 147.0 149.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:29:58 INFO - PROCESS | 9743 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.05 19:29:58 INFO - PROCESS | 9743 | Values: 57.0 55.0 58.0 55.0 56.0 55.0 56.0 55.0 57.0 56.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 19:29:58 INFO - PROCESS | 9743 | Values: 62.0 62.0 61.0 62.0 63.0 63.0 62.0 64.0 63.0 62.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.00 stddev:13.08 (16.1%) stddev-sans-first:13.75 19:29:58 INFO - PROCESS | 9743 | Values: 80.0 80.0 79.0 83.0 82.0 81.0 81.0 83.0 122.0 79.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.00 stddev:7.92 (6.0%) stddev-sans-first:8.40 19:29:58 INFO - PROCESS | 9743 | Values: 130.0 123.0 143.0 132.0 121.0 143.0 126.0 135.0 128.0 123.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.50 stddev:3.91 (2.4%) stddev-sans-first:4.14 19:29:58 INFO - PROCESS | 9743 | Values: 161.0 165.0 168.0 164.0 158.0 159.0 167.0 160.0 157.0 159.0 19:29:58 INFO - PROCESS | 9743 | 19:29:58 INFO - PROCESS | 9743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 19:29:58 INFO - PROCESS | 9743 | Values: 65.0 67.0 63.0 65.0 66.0 64.0 63.0 62.0 63.0 64.0 19:29:58 INFO - PROCESS | 9743 | -------- Summary: end -------- 19:29:58 INFO - PROCESS | 9743 | 19:29:59 INFO - TEST-INFO | 9743: exit 0 19:29:59 INFO - TEST-OK | kraken | took 63525ms 19:29:59 INFO - SUITE-END | took 1176s 19:29:59 INFO - Completed test suite (00:19:36) 19:29:59 INFO - javascript benchmark 19:29:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7211.625089213633, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.7962382445126, 3139.4192074466227, 3153.62156541215, 3158.88943886964, 3166.0185342543828, 5260.342457192851, 5292.603054770893, 5304.177852432874, 5311.0, 5325.440828712987, 5245.344331958505, 5332.0, 5346.599005074616, 5390.272313237711, 5397.352317721869, 4820.060088282787, 4861.1492988727005, 4940.728259945701, 4985.326980857592, 5028.446870844205, 799.6166810650242, 4765.475797662271, 4834.516548345173, 4867.050925069613, 4927.0, 4833.25084611884, 4856.878578035559, 4876.4148302203785, 4885.5358740919555, 4907.312976183337, 4884.975575122137, 4885.828995985124, 4889.853304400838, 4900.632452566037, 4935.827246046371, 4772.928406073877, 4795.640326975491, 4799.976000120012, 4840.298156767284, 4842.249451335014, 5232.970612628293, 5241.318628578299, 5261.473852614746, 5301.522862942354, 5362.061639213122, 5623.887522249573, 5745.2243947067445, 5760.481556659879, 5765.1928729977835, 5775.27809023872, 5759.971200143972, 5783.363829978699, 5802.245708057925, 5823.854403639901, 5839.445252700986, 5385.8114965976, 5430.5927055471, 5435.918461223085, 5439.945600544023, 5468.425815289377, 5761.3950535194035, 5842.006858834008, 5893.587448878623, 5937.970310148508, 5950.523958083343, 5663.943360566424, 5721.485066344049, 5726.599138060295, 5729.255196824386, 5773.566982476331, 5798.304203495608, 5800.941990580124, 5806.0, 5807.041838096667, 5813.069908814569, 5589.077802162597, 5691.430856914276, 5737.598368114275, 5776.0, 5786.768529258867, 5758.74085666146, 5781.103928891029, 5794.971025144847, 5804.970975145182, 5841.182234487175, 4378.16814805186, 4405.581469760367, 4415.845445409395, 4419.889502762392, 4437.955620443819, 3857.1707082977296, 3896.0259935016247, 3934.803259836997, 3940.389239667856, 3954.189391174802, 5355.464453554613, 5425.484578964992, 5455.809046683347, 5471.398146203915, 5503.394626591072, 5797.652140871477, 5803.506701930299, 5826.79606213789, 5828.679422631796, 5829.09649004405, 5358.490943360374, 5388.3533975922355, 5404.054290499147, 5421.969825733098, 5497.422770609109, 4918.926216106761, 4958.057968985881, 4967.552920237196, 4987.700737955734, 4989.650724449326, 5912.438318359749, 5939.792107276225, 5943.940560594425, 5946.0, 5952.255968003999, 5644.548436125018, 5763.9135412968, 5777.653340799649, 5787.305523337226, 5790.913136302875, 5917.023691091094, 5967.433093856077, 5984.102384642339, 6000.039993601003, 6026.638401695912, 5723.370429252695, 5730.255066841284, 5733.31200255972, 5735.082386818089, 5739.799107031234, 5716.256886604881, 5769.74036168365, 5830.854228644148, 5842.1820945066875, 5854.414558544111, 5667.744951477111, 5668.234788303526, 5669.177969194526, 5674.74463649145, 5687.516561092188, 5667.659940403589, 5690.5163061140265, 5693.9430605693415, 5695.572832037697, 5708.4862362387585, 5436.728163591725, 5519.282493276009, 5526.336839579276, 5575.135853942646, 5596.796688711946, 5632.859178520406, 5657.745401456862, 5670.234518339971, 5674.631148975303, 5679.659220446786, 5570.24801651788, 5573.749181286771, 5574.08027675429, 5592.105263157875, 5598.496135347838], "value": 5281.441646815552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6335708503644, 599.8170557979814, 620.0451304990314, 645.0936434309793, 645.3353046362246, 43742.0, 45306.773466132705, 45419.31871021933, 45473.77263113688, 49318.50681493184, 46825.53174468254, 47213.7639311803, 47279.76360118195, 47564.0, 47585.52414475854, 8904.109589041109, 8990.460572365646, 9028.548572571344, 9031.09689031095, 9049.864252036225, 8868.600912958933, 8951.641934322652, 9023.413478123934, 9037.728868133967, 9043.773905652346, 9030.638774449015, 9105.089491050909, 9126.041765614615, 9138.0405057469, 9148.451092934445, 8938.821223575525, 9028.41315314509, 9034.05142460042, 9044.09559044097, 9046.728598142066, 8917.687880924137, 8986.775330616721, 9050.411723238034, 9056.683016094405, 9059.50172740499, 43744.343834842504, 43832.78083609593, 43865.34201986973, 44056.559434405564, 44365.55634443647, 3332.1169889979174, 3464.1512829356716, 3603.69368603669, 3617.927641447183, 3673.8530458781615, 31006.379872402427, 33098.50352244718, 33764.6623533764, 33791.662083379095, 33842.153946151295, 4260.10537787062, 4321.675874309408, 4354.54277300882, 4489.775511224459, 4491.73049617024, 375950.12024939974, 376059.99999999726, 376116.0, 378325.0, 380940.0, 62210.37789622046, 62366.68816655887, 62547.374526255066, 62659.37340626626, 62845.68577157085, 64801.35198648048, 65486.345136548975, 65709.67145164244, 65755.34244657587, 65948.68102638016, 17577.296908123786, 17629.559261018578, 18064.277428902697, 18245.270189192284, 18579.44261672152, 13832.861671383158, 14012.579622611338, 14033.017688761689, 14048.789268160986, 14070.085444446078, 20134.597308053755, 20185.0, 20197.394078177676, 20226.47169103862, 20260.89869550643, 7045.225025247219, 7316.414686825041, 7398.667059982314, 7442.18136005039, 7468.21583733711, 1054.3937236089125, 1152.654203738875, 1201.7536405036947, 1203.4283715235192, 1230.4647478346947, 32307.192320191712, 33278.66721332756, 33718.831405842815, 33879.49180762291, 34304.65695343065, 1105.3975583307117, 1143.0798207442922, 1143.1255089856268, 1184.8163534652142, 1207.269601890861, 17350.557746032406, 17605.64788704219, 17649.205785739672, 17700.29198832032, 17881.821181788277, 609545.0, 610484.0, 612964.0, 615705.0, 615830.0, 60133.09800352998, 60264.397356026755, 60631.393686062576, 60689.0, 61037.0, 1351.885089767361, 1379.4344318829233, 1415.978760318596, 1425.5010746238734, 1433.6917562723856, 32083.679163208068, 32914.67085329116, 33039.50440743439, 33159.0, 33455.0, 53940.730296348265, 54088.45911540992, 54112.45887541232, 54444.18333725077, 54499.455005451025, 474451.0, 478124.0, 478368.0, 478985.0, 479154.0, 28729.0, 29115.0, 29770.70229297679, 29843.850780745957, 29902.0, 49893.00213995772, 50479.0, 51190.0, 51688.0, 52181.0, 42369.36445953375, 43567.0, 43644.78177609092, 43779.0, 44128.33807492955, 42035.15929681328, 42054.15891682088, 42776.77275709088, 43119.56880431156, 43179.78410107929, 36569.08577285483, 41293.58706412897, 41582.584174159085, 42162.36756448717, 42239.0, 35060.824695876356, 37755.244895101394, 37770.2445951074, 38091.42862857115, 38143.23713525658, 28531.714682853737, 28864.42271154607, 28909.421811564072, 29426.852865735535, 29499.0], "value": 21085.548219200984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7569917403275, 383.6317135549872, 388.44258489068187, 399.49663424085645, 402.5692509015351, 17332.393366232183, 18946.62106757864, 19767.110480028397, 19886.60226795465, 19962.30131945384, 18224.27102915882, 18585.256589736393, 18798.0, 18896.338628147983, 18941.52646183846, 5398.676079435227, 5422.91865622016, 5540.750666220009, 5553.888922221553, 5617.213590097369, 5468.425815289397, 5515.972420137894, 5550.750216240279, 5555.638883472561, 5586.24585680934, 5236.0, 5496.0931446311315, 5501.229827824108, 5507.366652834915, 5519.39286678465, 5482.698451585161, 5517.227588137664, 5574.721263936827, 5581.079121944895, 5598.524125449342, 5617.325920889479, 5622.044252477048, 5627.380988091307, 5648.915266271009, 5662.320521537442, 18538.721919171225, 21734.0, 21978.670319945213, 22570.0, 22664.0, 2031.7866624004562, 2215.7784221577713, 2219.223271854854, 2431.7811396974357, 2446.0949448704096, 9649.807003859954, 9793.262211680763, 9801.901980980241, 10067.798644027152, 10072.94963525185, 1837.2926423327115, 1922.09661459114, 1927.4795805132535, 1929.4018854155256, 1973.851961102923, 72603.63698181475, 76788.61605691936, 78582.60708696477, 78819.6059019707, 79060.60469697672, 10575.0, 10607.257491975488, 10896.237263391486, 11102.111831053497, 11135.443227838576, 15170.31733571992, 15365.462208822637, 15374.769378459332, 15387.076775393512, 15437.84562154364, 8268.710595129141, 8333.541655208901, 8495.980482342158, 8546.102659220816, 8624.878765760412, 7515.210902855121, 7633.503822251647, 7719.189485104095, 7720.922790772132, 8254.42219044661, 4682.0, 4746.359241502353, 4789.3294938708605, 4807.543283388072, 4822.590079843182, 1979.1984246380239, 1990.9701354479694, 1998.7701414337537, 2000.109951071759, 2053.435305291027, 899.7210864631985, 972.1979367022235, 978.2907392140642, 1037.6005237983431, 1056.9207309451822, 18293.81706182948, 18624.255029798656, 18718.71921921172, 18793.248270069318, 18901.81098189028, 996.940183588987, 1014.1633152649094, 1025.3130402630256, 1028.4189432970347, 1080.6649938519083, 10077.29458937882, 10585.523651435704, 10625.043746062891, 10671.626493072705, 10699.411532365795, 463213.0, 463902.0, 471229.0, 480625.0, 483723.0, 72438.0, 78970.0, 83690.0, 90173.54913225523, 92831.53584232036, 1021.8211812932707, 1026.6899476178598, 1038.1227862456212, 1066.5627092891878, 1075.188232884183, 16776.748348774534, 16827.831721682625, 17272.568185795455, 17415.47753567395, 17641.735373969143, 28723.712762872103, 29323.560146597392, 40561.79719101386, 41137.58862411338, 41970.37044444397, 51718.74140629273, 51953.740231300115, 54407.45592544024, 60213.0, 60902.69548652229, 8137.145599712182, 8539.65589592937, 8669.91330086691, 8717.389782715403, 8797.692080777142, 11893.643190703946, 12850.742985140057, 12993.155444896052, 13073.411696473871, 13139.671508212372, 11681.415929203677, 11714.531418743496, 11723.237989530653, 11725.296482211095, 11996.880031199576, 10999.120070394189, 11785.292882427082, 11864.703382415508, 11926.344051077274, 11959.461824217757, 11733.706657333294, 11942.40879401014, 11966.58116965902, 12227.205231659913, 12350.0, 8492.363072769444, 8514.70198543048, 8528.0, 8594.527300998256, 8656.091110433314, 11332.320060796048, 11879.287242765462, 11885.762284754084, 11936.880631193577, 12129.090318225992], "value": 9063.276549080361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.2144263540324, 1482.725695746287, 1613.9677206455872, 1756.7364895265716, 1758.8504977076957, 7146.96426517868, 8061.113277539466, 8182.2226888445575, 8732.694355697551, 8744.387892847502, 8264.173582641733, 8508.234258916696, 8529.0, 8553.871691924625, 8583.570821458918, 2182.138055468089, 2206.249875042485, 2217.4899773052207, 2219.034719896842, 2222.355516900105, 2213.3359992002415, 2229.554089182162, 2269.818414526842, 2272.8068114210314, 2282.988585057072, 2210.2816584609986, 2221.133757834438, 2229.1194977983687, 2235.9888200558976, 2252.3355610094977, 2163.167180635451, 2167.8807665578465, 2173.0, 2180.1061564758375, 2185.6065908136607, 2150.086213359316, 2157.0, 2159.5464952359866, 2159.546495236002, 2169.0673010605433, 8463.195996380335, 8480.66077356905, 8508.78728031798, 8514.318854491688, 8534.829303413959, 4910.508949105097, 5006.424261209971, 5006.774695138727, 5007.198848184273, 5016.347874776292, 3017.8943736969322, 3091.6753740857334, 3105.394448082625, 3119.625644922624, 3127.061881435583, 1094.1574987259844, 1103.2112039891435, 1133.0, 1137.744007598292, 1147.5295128997154, 11347.489362978686, 11463.999999999916, 11466.598669046543, 11469.88530114705, 11478.081753459786, 4264.722793018444, 4312.633426158749, 4351.173277077345, 4374.147041326911, 4428.689991700615, 9728.75678108053, 9730.854037189449, 9747.902520974842, 9753.609855605697, 9754.122129008423, 4906.975465122651, 4976.278439626234, 4988.301637770715, 4988.72562009093, 5029.094762942632, 4000.4599379084034, 4444.11117776446, 4581.748003859753, 4590.793414296365, 4596.839110631112, 3748.625137486284, 3758.680512156497, 3810.123671555558, 3821.980890095532, 3936.3111455495173, 1140.9543618255177, 1142.9142814288962, 1158.7624536969902, 1159.565163063851, 1185.8399116119385, 894.5437826708426, 926.8841394825647, 966.6375109334, 967.9322447428613, 1005.3465247588979, 5676.318841739017, 5776.42235776419, 5820.563457740686, 6049.848753781191, 6057.515398768088, 965.6620182935916, 969.8351280282228, 980.6028558433845, 1003.3678782367062, 1047.1884289675563, 4126.968257935516, 4136.296829538986, 4168.270552653274, 4212.410262563182, 4214.936775948363, 10096.798064038825, 10300.536475858604, 10464.476776161313, 10486.161107111566, 10487.895121048692, 10273.383596984206, 10327.586896524055, 10343.27597068213, 10375.533101010473, 10378.06597406237, 7482.214367491444, 7718.884216736641, 7760.456768026297, 7896.881546776803, 7972.123066462685, 5864.882702346014, 5979.073243647242, 5999.850003749942, 6045.969770151121, 6119.44924956756, 8938.955305223431, 9278.0, 9282.489463079595, 9378.343515953818, 9468.905310946802, 9327.906720932975, 9499.050094990445, 9585.0, 9612.807743845224, 9614.278929080487, 7293.307135822089, 7326.084239470067, 7335.266473352622, 7369.189389167294, 7392.4825262231125, 7594.278543538355, 7608.885866711893, 7635.0, 7647.470505898954, 7742.729004484816, 7061.788146355618, 7266.818329541804, 7306.525075870051, 7348.191698913222, 7363.77908662741, 7072.009918611501, 7088.113985751781, 7118.110236220473, 7210.351068403869, 7300.16048154469, 6764.526483146329, 6769.526133170828, 6780.966095169492, 6837.829054273484, 6842.623655698984, 4745.477997420212, 4878.438979517401, 4945.703257804544, 5071.847844564669, 5157.510036546522, 5019.648624596243, 5087.084324821568, 5099.260607212008, 5112.488751125006, 5155.742212889416], "value": 4444.772558647061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.5250959294079, 325.3590426859088, 330.97848639838423, 331.4828866967531, 331.6534221738284, 5486.231927530149, 5529.364123125842, 5674.375818659944, 5708.944779879245, 5759.39526349733, 5568.52667523261, 5571.415001424853, 5594.328680558328, 5644.181593668915, 5644.8306550803545, 4385.758783266919, 4390.84632037878, 4402.823887044515, 4416.22716024696, 4416.955830441702, 4141.0, 4336.024394511242, 4337.436133302666, 4423.159599676052, 4451.955480445203, 4293.248681480744, 4304.935425968613, 4311.331743579734, 4312.482502099752, 4355.738655680653, 4276.379924910871, 4316.6762492813, 4319.33050377192, 4326.459192600925, 4350.782460876975, 3699.3896007158787, 3737.757045792042, 3782.583915769263, 3790.753601015925, 3802.1445174835717, 5306.7611957462, 5333.546648534879, 5349.545288650469, 5350.732463376816, 5400.810971616014, 4871.634627402959, 4962.6526143169995, 4963.652544321899, 4984.227444746034, 4993.926305844225, 5628.296462942132, 5839.737211825478, 5889.440503152194, 5922.0, 5937.67342796146, 4138.544760076389, 4165.271077561415, 4172.144710334374, 4182.1008483176265, 4184.163167366509, 6045.851288255218, 6110.9611366067875, 6163.414475624809, 6170.81487555374, 6182.938170618326, 4126.3397856343445, 4176.352665336817, 4197.601227883346, 4228.788560571959, 4238.173556156582, 4230.090530535888, 4233.809478573472, 4233.91532169361, 4239.851605193865, 4240.279152544075, 4869.415670119608, 4908.386451693538, 4919.483454237254, 4922.950770492249, 4956.628252881048, 5707.315122185364, 5873.383294754075, 5889.0, 5894.2926848778425, 5905.228431470542, 1466.7213229486363, 1469.419579266184, 1473.9631509212356, 1478.9186594737178, 1491.2394678713717, 918.4334425785785, 927.4806108579218, 931.38993958957, 942.4345392764286, 947.393668052447, 5041.42023667283, 5067.239914012927, 5088.5420312171345, 5139.0471620783865, 5143.228515722597, 5393.568514518829, 5397.568194544427, 5431.918521222185, 5454.91817622736, 5467.17992301158, 4848.466668666444, 5025.623078269145, 5040.79021034949, 5049.722265275445, 5059.241113832881, 2885.264257614295, 2896.319364949235, 2942.3379739558854, 2943.955840662392, 2949.513330300519, 5518.179000929684, 5548.6960564267365, 5561.638493497991, 5592.245046918695, 5603.271574695264, 5328.600354973392, 5422.972885135549, 5475.534579560782, 5494.36814766299, 5495.587830912617, 5521.861953451196, 5573.944260557424, 5574.2719756875495, 5607.186957891165, 5625.324961004788, 5238.76425560843, 5438.776275338176, 5484.369297530835, 5490.258815060076, 5520.696361699985, 5310.761015754378, 5389.197617238935, 5470.17947307907, 5476.658218736435, 5506.733451306142, 5612.01789686795, 5654.208410822406, 5658.81164955364, 5699.0, 6012.218411606463, 4179.895502612459, 4230.027093768389, 4236.6187043166265, 4238.088810905547, 4252.617264446215, 6056.182415373868, 6065.848353791191, 6076.787312444043, 6096.878062438637, 6099.4510494053975, 5675.858103547444, 5839.591228613956, 5848.385919478394, 5898.0, 5903.0, 5845.152452894392, 5847.093700476433, 5856.238688970407, 5869.148973398918, 5870.911936320873, 5738.971305143447, 5770.192173095854, 5809.779946211343, 5825.76696932118, 5830.7959221427045, 5749.712514374348, 5920.0, 5978.312494063064, 6027.939720602913, 6036.486898613667, 5897.882042359043, 5924.6149000314845, 5932.9703351484695, 5951.315598706205, 5954.434328738763], "value": 4327.555027220483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.1483878700708, 765.2462324610258, 772.2007722007723, 786.5162924801247, 801.5311043039821, 14505.274736263184, 14541.345639446225, 14730.852691473083, 14893.180875051868, 14919.627009324759, 13681.589552313446, 13713.794293085612, 13714.931425342884, 13777.586672399844, 13786.241756703377, 673.7069374821943, 785.9135495095535, 799.73608709126, 810.0360570920585, 811.4847072109224, 805.0701439836997, 805.730080423056, 809.295912556077, 812.6749300279877, 817.81190326225, 874.8337815815007, 877.4165180155189, 878.1613559051091, 878.569500944539, 878.9165029322204, 863.896332440105, 867.4665080975186, 870.525563567857, 873.4060838629729, 874.9168828961239, 632.3992207402986, 635.3075148088606, 636.2174525333866, 637.1939496536885, 637.8851806674796, 12906.67733306675, 12965.0, 12976.091673582852, 12979.286139262336, 12989.025823063308, 14615.12309261437, 14715.852841471555, 15391.307391167424, 15465.304061317267, 15738.606534836606, 12052.337121458317, 12081.45633446497, 12172.939135304267, 12432.502699891993, 12522.0, 3797.544294684628, 3799.1831756172555, 3813.6186381361917, 3831.4252862070634, 3962.960370396288, 74996.62501687456, 75973.62013189899, 76695.61652191704, 76805.0, 76858.23141768623, 10869.945650271698, 11136.0, 11232.775344493064, 11385.203035787416, 11444.427778611036, 22907.541849163255, 22935.770642293362, 22938.65592016121, 22947.311580652608, 22991.0, 7949.801254968672, 8081.111077781439, 8210.0, 8431.19903609156, 8494.0, 4392.604665580113, 4597.402337696078, 4656.627469802408, 4724.952750472451, 4804.519548045238, 3154.14837993745, 3273.4762438009802, 3287.4904389819617, 3291.8683252670103, 3305.0, 571.7998700454891, 577.0795581048221, 580.5587753307432, 581.5899790647584, 582.0512564519805, 666.7366390275814, 675.7094449386713, 692.3491917597443, 700.6531766775479, 741.3698356397019, 9275.871131541347, 9580.904190958001, 10028.387838313172, 10057.273200604848, 10124.392536447836, 582.3564960718345, 694.4097517110416, 701.9859602807916, 702.220535205921, 732.8607564562716, 4496.213162696515, 4677.766111694402, 4723.149833030087, 4754.477007529169, 4759.452662943737, 102366.48816755868, 102999.48500257601, 103495.4825225869, 105065.0, 106509.46745266224, 89070.0, 90105.0, 90326.0, 90673.0, 90725.54637226903, 78918.60540697374, 79133.20866791373, 79671.20328796637, 80133.59933200413, 80505.19494805094, 8311.584420779058, 8349.039860415887, 8368.250749295381, 8519.787005324917, 8683.175098365646, 43154.352684710386, 50031.749206270135, 50637.746811267185, 50981.23528147155, 51152.48847511477, 64719.35280647133, 66004.33995659983, 71176.0, 73305.13558915381, 74768.62615687105, 11033.393163376091, 11046.558137674725, 11092.611758588733, 11366.943165284121, 11847.526098955945, 12420.378981051092, 12832.101752877208, 12944.741105178033, 13045.673858153623, 13059.608211753663, 11947.223430476992, 12054.879451205376, 12309.44607492683, 12675.492980280686, 13006.544770932973, 11883.0, 11892.286462812259, 12135.635930922086, 12169.20900141488, 12432.067594930597, 11440.084793216689, 11862.762744745229, 11874.719465363116, 11937.224080435091, 12239.75520489603, 10246.38521688701, 10381.896181038395, 10955.287906286067, 11210.66368008961, 11258.718532036764, 10338.793224135325, 10964.451777411257, 11038.0, 11167.888321116685, 11288.2662626929], "value": 7244.971420793207, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 156.0, 177.0, 126.0, 163.0, 165.0, 129.0, 178.0, 132.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 163.0, 176.0, 161.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 161.0, 77.0, 75.0, 76.0, 75.0, 159.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 152.0, 86.0, 85.0, 89.0, 150.0, 86.0, 86.0, 152.0], "value": 105.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 58.0, 55.0, 56.0, 55.0, 56.0, 55.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 83.0, 82.0, 81.0, 81.0, 83.0, 122.0, 79.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 143.0, 132.0, 121.0, 143.0, 126.0, 135.0, 128.0, 123.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 168.0, 164.0, 158.0, 159.0, 167.0, 160.0, 157.0, 159.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 63.0, 65.0, 66.0, 64.0, 63.0, 62.0, 63.0, 64.0], "value": 64.2, "unit": "score"}]}]} 19:29:59 INFO - Return code: 0 19:29:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:29:59 ERROR - # TBPL SUCCESS # 19:29:59 INFO - Running post-action listener: _resource_record_post_action 19:29:59 INFO - ##### 19:29:59 INFO - ##### Finished run-tests step (success) 19:29:59 INFO - ##### 19:29:59 INFO - Running post-run listener: _resource_record_post_run 19:29:59 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 8192; Write bytes: 541335552; Read time: 356; Write time: 909968 19:29:59 INFO - TinderboxPrint: CPU usage
13.6% 19:29:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 356 19:29:59 INFO - TinderboxPrint: I/O write bytes / time
541,335,552 / 909,968 19:29:59 INFO - TinderboxPrint: CPU idle
8,230.5 (86.4%) 19:29:59 INFO - TinderboxPrint: CPU user
1,230.6 (12.9%) 19:29:59 INFO - TinderboxPrint: Swap in / out
0 / 0 19:29:59 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248389632; Read time: 0; Write time: 527912 19:29:59 INFO - run-tests - Wall time: 1178s; CPU: 14.0%; Read bytes: 8192; Write bytes: 292945920; Read time: 356; Write time: 382056 19:30:00 INFO - Running post-run listener: _upload_blobber_files 19:30:00 INFO - Blob upload gear active. 19:30:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:00 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 19:30:00 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:30:00 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:01 INFO - (blobuploader) - INFO - Done attempting. 19:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:01 INFO - (blobuploader) - INFO - Done attempting. 19:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:05 INFO - (blobuploader) - INFO - Done attempting. 19:30:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:05 INFO - Return code: 0 19:30:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf563a4e0b1f01fa5c26c677f521447f2448867e9c062f001811b0deb6b113a13e0458b606aec8a649cd0f8e10298c650fd8524e7af202b0a3d7c691d9f17523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6fc9c38d9acee2ba9c656f7ff1157b26cd0c1d74b83869113fcb91efbca7706cf15535d2fc14781393db4402a33bb491e780e6db210ba0bab1b2ce2bc77958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb271206efd451bea2aadf18451750bff2801bb07a0ee5bb859aaaa42d2d1bd85d17a21d72520cf6a8f1022898c493b2283bc2ac3f48da2a736de1ea6935c4d"} 19:30:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:05 INFO - Contents: 19:30:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf563a4e0b1f01fa5c26c677f521447f2448867e9c062f001811b0deb6b113a13e0458b606aec8a649cd0f8e10298c650fd8524e7af202b0a3d7c691d9f17523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6fc9c38d9acee2ba9c656f7ff1157b26cd0c1d74b83869113fcb91efbca7706cf15535d2fc14781393db4402a33bb491e780e6db210ba0bab1b2ce2bc77958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb271206efd451bea2aadf18451750bff2801bb07a0ee5bb859aaaa42d2d1bd85d17a21d72520cf6a8f1022898c493b2283bc2ac3f48da2a736de1ea6935c4d"} 19:30:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:05 INFO - Copying logs to upload dir... 19:30:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.007232 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-08 19:30:05.664528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:30:05.667992) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf563a4e0b1f01fa5c26c677f521447f2448867e9c062f001811b0deb6b113a13e0458b606aec8a649cd0f8e10298c650fd8524e7af202b0a3d7c691d9f17523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6fc9c38d9acee2ba9c656f7ff1157b26cd0c1d74b83869113fcb91efbca7706cf15535d2fc14781393db4402a33bb491e780e6db210ba0bab1b2ce2bc77958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb271206efd451bea2aadf18451750bff2801bb07a0ee5bb859aaaa42d2d1bd85d17a21d72520cf6a8f1022898c493b2283bc2ac3f48da2a736de1ea6935c4d"} build_url:https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/eY2UHyDBTzqgCc2kspjWxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf563a4e0b1f01fa5c26c677f521447f2448867e9c062f001811b0deb6b113a13e0458b606aec8a649cd0f8e10298c650fd8524e7af202b0a3d7c691d9f17523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6fc9c38d9acee2ba9c656f7ff1157b26cd0c1d74b83869113fcb91efbca7706cf15535d2fc14781393db4402a33bb491e780e6db210ba0bab1b2ce2bc77958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb271206efd451bea2aadf18451750bff2801bb07a0ee5bb859aaaa42d2d1bd85d17a21d72520cf6a8f1022898c493b2283bc2ac3f48da2a736de1ea6935c4d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:30:05.696312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:30:05.696901) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465438167.152482-509000127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:30:05.777290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:30:05.777609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:30:05.777908) ========= ========= Total master_lag: 0.18 =========