builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1466763904.52 results: success (0) buildid: 20160624004013 builduid: c97fb67c98fb46ff84b69eca356ce455 revision: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.519282) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.520164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.520625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.539676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.540193) ========= 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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 03:25:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-06-24 03:25:05 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.663621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.664084) ========= 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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.716894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:04.717517) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c --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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 03:25:05,163 truncating revision to first 12 chars 2016-06-24 03:25:05,163 Setting DEBUG logging. 2016-06-24 03:25:05,164 attempt 1/10 2016-06-24 03:25:05,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75ff1ecbcb09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 03:25:05,653 unpacking tar archive at: mozilla-aurora-75ff1ecbcb09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:05.573868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:05.574295) ========= script_repo_revision: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:05.574778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:05.575124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:25:05.585076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-24 03:25:05.585627) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:06 INFO - MultiFileLogger online at 20160624 03:25:06 in /builds/slave/test 03:25:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:25:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:06 INFO - {'append_to_log': False, 03:25:06 INFO - 'base_work_dir': '/builds/slave/test', 03:25:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:25:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:06 INFO - 'branch': 'Mozilla-Aurora', 03:25:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:06 INFO - 'config_files': ('talos/linux_config.py',), 03:25:06 INFO - 'default_actions': ('clobber', 03:25:06 INFO - 'read-buildbot-config', 03:25:06 INFO - 'download-and-extract', 03:25:06 INFO - 'populate-webroot', 03:25:06 INFO - 'create-virtualenv', 03:25:06 INFO - 'install', 03:25:06 INFO - 'run-tests'), 03:25:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:06 INFO - 'download_minidump_stackwalk': True, 03:25:06 INFO - 'download_symbols': 'ondemand', 03:25:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:06 INFO - 'installer_path': 'installer.exe', 03:25:06 INFO - 'log_level': 'info', 03:25:06 INFO - 'log_name': 'talos', 03:25:06 INFO - 'log_to_console': True, 03:25:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:06 INFO - 'opt_config_files': (), 03:25:06 INFO - 'pip_index': False, 03:25:06 INFO - 'sps_profile': False, 03:25:06 INFO - 'sps_profile_interval': 0, 03:25:06 INFO - 'suite': 'dromaeojs-e10s', 03:25:06 INFO - 'system_bits': '32', 03:25:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:06 INFO - 'title': 'talos-linux64-ix-024', 03:25:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:06 INFO - 'use_talos_json': True, 03:25:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:06 INFO - 'work_dir': 'build'} 03:25:06 INFO - ##### 03:25:06 INFO - ##### Running clobber step. 03:25:06 INFO - ##### 03:25:06 INFO - Running pre-action listener: _resource_record_pre_action 03:25:06 INFO - Running main action method: clobber 03:25:06 INFO - rmtree: /builds/slave/test/build 03:25:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:07 INFO - Running post-action listener: _resource_record_post_action 03:25:07 INFO - ##### 03:25:07 INFO - ##### Finished clobber step (success) 03:25:07 INFO - ##### 03:25:07 INFO - ##### 03:25:07 INFO - ##### Running read-buildbot-config step. 03:25:07 INFO - ##### 03:25:07 INFO - Running pre-action listener: _resource_record_pre_action 03:25:07 INFO - Running main action method: read_buildbot_config 03:25:07 INFO - Using buildbot properties: 03:25:07 INFO - { 03:25:07 INFO - "project": "", 03:25:07 INFO - "product": "firefox", 03:25:07 INFO - "script_repo_revision": "production", 03:25:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:25:07 INFO - "repository": "", 03:25:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:25:07 INFO - "buildid": "20160624004013", 03:25:07 INFO - "stage_platform": "linux64-pgo", 03:25:07 INFO - "basedir": "/builds/slave/test", 03:25:07 INFO - "nightly_build": "True", 03:25:07 INFO - "buildnumber": 370, 03:25:07 INFO - "slavename": "talos-linux64-ix-024", 03:25:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:07 INFO - "platform": "ubuntu64_hw", 03:25:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:25:07 INFO - "branch": "mozilla-aurora", 03:25:07 INFO - "repo_path": "releases/mozilla-aurora", 03:25:07 INFO - "revision": "75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c", 03:25:07 INFO - "pgo_build": "True", 03:25:07 INFO - "builduid": "c97fb67c98fb46ff84b69eca356ce455", 03:25:07 INFO - "slavebuilddir": "test" 03:25:07 INFO - } 03:25:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:25:07 INFO - Running post-action listener: _resource_record_post_action 03:25:07 INFO - ##### 03:25:07 INFO - ##### Finished read-buildbot-config step (success) 03:25:07 INFO - ##### 03:25:07 INFO - ##### 03:25:07 INFO - ##### Running download-and-extract step. 03:25:07 INFO - ##### 03:25:07 INFO - Running pre-action listener: _resource_record_pre_action 03:25:07 INFO - Running main action method: download_and_extract 03:25:07 INFO - mkdir: /builds/slave/test/build/tests 03:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:07 INFO - https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:07 INFO - Downloaded 1361 bytes. 03:25:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:07 INFO - Using the following test package requirements: 03:25:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'jsshell-linux-x86_64.zip'], 03:25:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:07 INFO - https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:09 INFO - Downloaded 24516600 bytes. 03:25:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:10 INFO - Return code: 0 03:25:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:10 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')]} 03:25:10 INFO - https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:11 INFO - Downloaded 24516600 bytes. 03:25:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:13 INFO - Return code: 0 03:25:13 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')]} 03:25:13 INFO - https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:14 INFO - Downloaded 10833369 bytes. 03:25:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:14 INFO - Return code: 0 03:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:14 INFO - https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:15 INFO - Downloaded 63602188 bytes. 03:25:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:15 INFO - mkdir: /builds/slave/test/properties 03:25:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:15 INFO - Contents: 03:25:15 INFO - build_url:https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:16 INFO - Running post-action listener: _resource_record_post_action 03:25:16 INFO - Running post-action listener: set_extra_try_arguments 03:25:16 INFO - ##### 03:25:16 INFO - ##### Finished download-and-extract step (success) 03:25:16 INFO - ##### 03:25:16 INFO - ##### 03:25:16 INFO - ##### Running populate-webroot step. 03:25:16 INFO - ##### 03:25:16 INFO - Running pre-action listener: _resource_record_pre_action 03:25:16 INFO - Running main action method: populate_webroot 03:25:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:16 INFO - '--tppagecycles', 03:25:16 INFO - '7'], 03:25:16 INFO - 'tests': ['tsvgm']}}, 03:25:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['damp', 'tps']}, 03:25:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'tests': ['damp', 'tps']}, 03:25:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['dromaeo_dom']}, 03:25:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['a11yr', 03:25:16 INFO - 'ts_paint', 03:25:16 INFO - 'tpaint', 03:25:16 INFO - 'sessionrestore', 03:25:16 INFO - 'sessionrestore_no_auto_restore', 03:25:16 INFO - 'tabpaint']}, 03:25:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['tsvgx', 03:25:16 INFO - 'tsvgr_opacity', 03:25:16 INFO - 'tart', 03:25:16 INFO - 'tscrollx', 03:25:16 INFO - 'cart']}, 03:25:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:16 INFO - 'tsvgr_opacity', 03:25:16 INFO - 'tart', 03:25:16 INFO - 'tscrollx', 03:25:16 INFO - 'cart']}, 03:25:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'talos_options': ['--disable-e10s'], 03:25:16 INFO - 'tests': ['tp5o']}, 03:25:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'tests': ['tp5o']}, 03:25:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'talos_options': ['--disable-e10s', 03:25:16 INFO - '--xperf_path', 03:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:16 INFO - 'tests': ['tp5n']}, 03:25:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:16 INFO - 'talos_options': ['--xperf_path', 03:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:16 INFO - 'tests': ['tp5n']}}, 03:25:16 INFO - 'talos.zip': {'path': '', 03:25:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:16 INFO - Running post-action listener: _resource_record_post_action 03:25:16 INFO - ##### 03:25:16 INFO - ##### Finished populate-webroot step (success) 03:25:16 INFO - ##### 03:25:16 INFO - ##### 03:25:16 INFO - ##### Running create-virtualenv step. 03:25:16 INFO - ##### 03:25:16 INFO - Running pre-action listener: _resource_record_pre_action 03:25:16 INFO - Running main action method: create_virtualenv 03:25:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:16 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 03:25:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:16 INFO - Using real prefix '/usr' 03:25:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:17 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:19 INFO - Installing pip.................done. 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:19 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')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:19 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 03:25:19 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 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 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 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:19 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')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:19 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 03:25:19 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 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 INFO - Downloading/unpacking psutil>=3.1.1 03:25:19 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 03:25:19 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 03:25:19 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 03:25:19 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 03:25:19 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 03:25:19 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 03:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:21 INFO - Installing collected packages: psutil 03:25:21 INFO - Running setup.py install for psutil 03:25:21 INFO - building 'psutil._psutil_linux' extension 03:25:21 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 03:25:21 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 03:25:21 INFO - building 'psutil._psutil_posix' extension 03:25:21 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 03:25:21 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 03:25:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:22 INFO - Successfully installed psutil 03:25:22 INFO - Cleaning up... 03:25:22 INFO - Return code: 0 03:25:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:25:22 INFO - Using env: {'DISPLAY': ':0', 03:25:22 INFO - 'HOME': '/home/cltbld', 03:25:22 INFO - 'LANG': 'en_US.UTF-8', 03:25:22 INFO - 'LANGUAGE': 'en_US:en', 03:25:22 INFO - 'LOGNAME': 'cltbld', 03:25:22 INFO - 'MAIL': '/var/mail/cltbld', 03:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:22 INFO - 'MOZ_NO_REMOTE': '1', 03:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:22 INFO - 'NO_EM_RESTART': '1', 03:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:22 INFO - 'PWD': '/builds/slave/test', 03:25:22 INFO - 'SHELL': '/bin/bash', 03:25:22 INFO - 'SHLVL': '1', 03:25:22 INFO - 'TERM': 'linux', 03:25:22 INFO - 'TMOUT': '86400', 03:25:22 INFO - 'USER': 'cltbld', 03:25:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:22 INFO - '_': '/tools/buildbot/bin/python'} 03:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:24 INFO - Installing collected packages: mozsystemmonitor 03:25:24 INFO - Running setup.py install for mozsystemmonitor 03:25:24 INFO - Successfully installed mozsystemmonitor 03:25:24 INFO - Cleaning up... 03:25:24 INFO - Return code: 0 03:25:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:24 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')]} 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:24 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')]} 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:24 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:24 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 03:25:24 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 03:25:24 INFO - Using env: {'DISPLAY': ':0', 03:25:24 INFO - 'HOME': '/home/cltbld', 03:25:24 INFO - 'LANG': 'en_US.UTF-8', 03:25:24 INFO - 'LANGUAGE': 'en_US:en', 03:25:24 INFO - 'LOGNAME': 'cltbld', 03:25:24 INFO - 'MAIL': '/var/mail/cltbld', 03:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:24 INFO - 'MOZ_NO_REMOTE': '1', 03:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:24 INFO - 'NO_EM_RESTART': '1', 03:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:24 INFO - 'PWD': '/builds/slave/test', 03:25:24 INFO - 'SHELL': '/bin/bash', 03:25:24 INFO - 'SHLVL': '1', 03:25:24 INFO - 'TERM': 'linux', 03:25:24 INFO - 'TMOUT': '86400', 03:25:24 INFO - 'USER': 'cltbld', 03:25:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:24 INFO - '_': '/tools/buildbot/bin/python'} 03:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:24 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 03:25:24 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 03:25:24 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 03:25:24 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 03:25:24 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 03:25:24 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 03:25:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:26 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 03:25:26 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 03:25:26 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 03:25:26 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 03:25:26 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 03:25:26 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 03:25:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:26 INFO - warning: no files found matching '*.txt' 03:25:26 INFO - no previously-included directories found matching 'build' 03:25:26 INFO - no previously-included directories found matching 'dist' 03:25:26 INFO - no previously-included directories found matching '.git*' 03:25:26 INFO - Installing collected packages: jsonschema, functools32 03:25:26 INFO - Running setup.py install for functools32 03:25:26 INFO - warning: no files found matching '*.txt' 03:25:26 INFO - no previously-included directories found matching 'build' 03:25:26 INFO - no previously-included directories found matching 'dist' 03:25:26 INFO - no previously-included directories found matching '.git*' 03:25:26 INFO - Successfully installed jsonschema functools32 03:25:26 INFO - Cleaning up... 03:25:27 INFO - Return code: 0 03:25:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:27 INFO - Using env: {'DISPLAY': ':0', 03:25:27 INFO - 'HOME': '/home/cltbld', 03:25:27 INFO - 'LANG': 'en_US.UTF-8', 03:25:27 INFO - 'LANGUAGE': 'en_US:en', 03:25:27 INFO - 'LOGNAME': 'cltbld', 03:25:27 INFO - 'MAIL': '/var/mail/cltbld', 03:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:27 INFO - 'MOZ_NO_REMOTE': '1', 03:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:27 INFO - 'NO_EM_RESTART': '1', 03:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:27 INFO - 'PWD': '/builds/slave/test', 03:25:27 INFO - 'SHELL': '/bin/bash', 03:25:27 INFO - 'SHLVL': '1', 03:25:27 INFO - 'TERM': 'linux', 03:25:27 INFO - 'TMOUT': '86400', 03:25:27 INFO - 'USER': 'cltbld', 03:25:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:27 INFO - '_': '/tools/buildbot/bin/python'} 03:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - Downloading docopt-0.6.1.tar.gz 03:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:29 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:29 INFO - Running setup.py install for blobuploader 03:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:29 INFO - Running setup.py install for requests 03:25:30 INFO - Running setup.py install for docopt 03:25:30 INFO - Successfully installed blobuploader requests docopt 03:25:30 INFO - Cleaning up... 03:25:30 INFO - Return code: 0 03:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:30 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:30 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 03:25:30 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 03:25:30 INFO - Using env: {'DISPLAY': ':0', 03:25:30 INFO - 'HOME': '/home/cltbld', 03:25:30 INFO - 'LANG': 'en_US.UTF-8', 03:25:30 INFO - 'LANGUAGE': 'en_US:en', 03:25:30 INFO - 'LOGNAME': 'cltbld', 03:25:30 INFO - 'MAIL': '/var/mail/cltbld', 03:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:30 INFO - 'MOZ_NO_REMOTE': '1', 03:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:30 INFO - 'NO_EM_RESTART': '1', 03:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:30 INFO - 'PWD': '/builds/slave/test', 03:25:30 INFO - 'SHELL': '/bin/bash', 03:25:30 INFO - 'SHLVL': '1', 03:25:30 INFO - 'TERM': 'linux', 03:25:30 INFO - 'TMOUT': '86400', 03:25:30 INFO - 'USER': 'cltbld', 03:25:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:30 INFO - '_': '/tools/buildbot/bin/python'} 03:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:30 INFO - Running setup.py (path:/tmp/pip-0YC_x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:30 INFO - Running setup.py (path:/tmp/pip-iIewAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:30 INFO - Running setup.py (path:/tmp/pip-WWtBbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:30 INFO - Running setup.py (path:/tmp/pip-KSmaF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:31 INFO - Running setup.py (path:/tmp/pip-lWx6h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:31 INFO - Running setup.py (path:/tmp/pip-mIwKJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:31 INFO - Running setup.py (path:/tmp/pip-kVIj41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:31 INFO - Running setup.py (path:/tmp/pip-HZw8WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:31 INFO - Running setup.py (path:/tmp/pip-IH921s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:31 INFO - Running setup.py (path:/tmp/pip-fFELSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:31 INFO - Running setup.py (path:/tmp/pip-8QKwGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:31 INFO - Running setup.py (path:/tmp/pip-1xaR27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:31 INFO - Running setup.py (path:/tmp/pip-eVCicy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:31 INFO - Running setup.py (path:/tmp/pip-nTf28U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:31 INFO - Running setup.py (path:/tmp/pip-e_Xp4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:31 INFO - Running setup.py (path:/tmp/pip-eZ66gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:31 INFO - Running setup.py (path:/tmp/pip-vGjrLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:31 INFO - Running setup.py install for manifestparser 03:25:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for mozcrash 03:25:32 INFO - Running setup.py install for mozdebug 03:25:32 INFO - Running setup.py install for mozdevice 03:25:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for mozfile 03:25:32 INFO - Running setup.py install for mozhttpd 03:25:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for mozinfo 03:25:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for mozInstall 03:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for mozleak 03:25:32 INFO - Running setup.py install for mozlog 03:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:32 INFO - Running setup.py install for moznetwork 03:25:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Running setup.py install for mozprocess 03:25:33 INFO - Running setup.py install for mozprofile 03:25:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Running setup.py install for mozrunner 03:25:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Running setup.py install for mozscreenshot 03:25:33 INFO - Running setup.py install for moztest 03:25:33 INFO - Running setup.py install for mozversion 03:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:33 INFO - Cleaning up... 03:25:33 INFO - Return code: 0 03:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:33 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:33 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 03:25:33 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 03:25:33 INFO - Using env: {'DISPLAY': ':0', 03:25:33 INFO - 'HOME': '/home/cltbld', 03:25:33 INFO - 'LANG': 'en_US.UTF-8', 03:25:33 INFO - 'LANGUAGE': 'en_US:en', 03:25:33 INFO - 'LOGNAME': 'cltbld', 03:25:33 INFO - 'MAIL': '/var/mail/cltbld', 03:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:33 INFO - 'MOZ_NO_REMOTE': '1', 03:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:33 INFO - 'NO_EM_RESTART': '1', 03:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:33 INFO - 'PWD': '/builds/slave/test', 03:25:33 INFO - 'SHELL': '/bin/bash', 03:25:33 INFO - 'SHLVL': '1', 03:25:33 INFO - 'TERM': 'linux', 03:25:33 INFO - 'TMOUT': '86400', 03:25:33 INFO - 'USER': 'cltbld', 03:25:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:33 INFO - '_': '/tools/buildbot/bin/python'} 03:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:33 INFO - Running setup.py (path:/tmp/pip-E1kalc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:34 INFO - Running setup.py (path:/tmp/pip-Iu2zoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:34 INFO - Running setup.py (path:/tmp/pip-qYjq44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:34 INFO - Running setup.py (path:/tmp/pip-j2uy2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:34 INFO - Running setup.py (path:/tmp/pip-wpRZbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:34 INFO - Running setup.py (path:/tmp/pip-oWjyvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:34 INFO - Running setup.py (path:/tmp/pip-2Gx4Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:34 INFO - Running setup.py (path:/tmp/pip-DQ4cZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:34 INFO - Running setup.py (path:/tmp/pip-PgDXzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:34 INFO - Running setup.py (path:/tmp/pip-HV1ASY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:34 INFO - Running setup.py (path:/tmp/pip-KPDPWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:34 INFO - Running setup.py (path:/tmp/pip-NFU7rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:34 INFO - Running setup.py (path:/tmp/pip-fQOtJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:34 INFO - Running setup.py (path:/tmp/pip-yT9uoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:34 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)) 03:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:34 INFO - Running setup.py (path:/tmp/pip-ws88s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:35 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)) 03:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:35 INFO - Running setup.py (path:/tmp/pip-yodZ0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:35 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)) 03:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:35 INFO - Running setup.py (path:/tmp/pip-J48L9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:35 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)) 03:25:35 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)) 03:25:35 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)) 03:25:35 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)) 03:25:35 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)) 03:25:35 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)) 03:25:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:35 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 03:25:35 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 03:25:35 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 03:25:35 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 03:25:35 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 03:25:35 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 03:25:37 INFO - Downloading blessings-1.6.tar.gz 03:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:37 INFO - Installing collected packages: blessings 03:25:37 INFO - Running setup.py install for blessings 03:25:37 INFO - Successfully installed blessings 03:25:37 INFO - Cleaning up... 03:25:37 INFO - Return code: 0 03:25:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:37 INFO - Reading from file tmpfile_stdout 03:25:37 INFO - Current package versions: 03:25:37 INFO - argparse == 1.2.1 03:25:37 INFO - blessings == 1.6 03:25:37 INFO - blobuploader == 1.2.4 03:25:37 INFO - docopt == 0.6.1 03:25:37 INFO - functools32 == 3.2.3-2 03:25:37 INFO - jsonschema == 2.5.1 03:25:37 INFO - manifestparser == 1.1 03:25:37 INFO - mozInstall == 1.12 03:25:37 INFO - mozcrash == 0.17 03:25:37 INFO - mozdebug == 0.1 03:25:37 INFO - mozdevice == 0.48 03:25:37 INFO - mozfile == 1.2 03:25:37 INFO - mozhttpd == 0.7 03:25:37 INFO - mozinfo == 0.9 03:25:37 INFO - mozleak == 0.1 03:25:37 INFO - mozlog == 3.2 03:25:37 INFO - moznetwork == 0.27 03:25:37 INFO - mozprocess == 0.22 03:25:37 INFO - mozprofile == 0.28 03:25:37 INFO - mozrunner == 6.11 03:25:37 INFO - mozscreenshot == 0.1 03:25:37 INFO - mozsystemmonitor == 0.3 03:25:37 INFO - moztest == 0.7 03:25:37 INFO - mozversion == 1.4 03:25:37 INFO - psutil == 3.1.1 03:25:37 INFO - requests == 1.2.3 03:25:37 INFO - wsgiref == 0.1.2 03:25:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:37 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:37 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 03:25:37 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 03:25:37 INFO - Using env: {'DISPLAY': ':0', 03:25:37 INFO - 'HOME': '/home/cltbld', 03:25:37 INFO - 'LANG': 'en_US.UTF-8', 03:25:37 INFO - 'LANGUAGE': 'en_US:en', 03:25:37 INFO - 'LOGNAME': 'cltbld', 03:25:37 INFO - 'MAIL': '/var/mail/cltbld', 03:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:37 INFO - 'MOZ_NO_REMOTE': '1', 03:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:37 INFO - 'NO_EM_RESTART': '1', 03:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:37 INFO - 'PWD': '/builds/slave/test', 03:25:37 INFO - 'SHELL': '/bin/bash', 03:25:37 INFO - 'SHLVL': '1', 03:25:37 INFO - 'TERM': 'linux', 03:25:37 INFO - 'TMOUT': '86400', 03:25:37 INFO - 'USER': 'cltbld', 03:25:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:37 INFO - '_': '/tools/buildbot/bin/python'} 03:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 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)) 03:25:37 INFO - Cleaning up... 03:25:37 INFO - Return code: 0 03:25:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:37 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:37 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 03:25:37 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 03:25:37 INFO - Using env: {'DISPLAY': ':0', 03:25:37 INFO - 'HOME': '/home/cltbld', 03:25:37 INFO - 'LANG': 'en_US.UTF-8', 03:25:37 INFO - 'LANGUAGE': 'en_US:en', 03:25:37 INFO - 'LOGNAME': 'cltbld', 03:25:37 INFO - 'MAIL': '/var/mail/cltbld', 03:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:37 INFO - 'MOZ_NO_REMOTE': '1', 03:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:37 INFO - 'NO_EM_RESTART': '1', 03:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:37 INFO - 'PWD': '/builds/slave/test', 03:25:37 INFO - 'SHELL': '/bin/bash', 03:25:37 INFO - 'SHLVL': '1', 03:25:37 INFO - 'TERM': 'linux', 03:25:37 INFO - 'TMOUT': '86400', 03:25:37 INFO - 'USER': 'cltbld', 03:25:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:37 INFO - '_': '/tools/buildbot/bin/python'} 03:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:37 INFO - Cleaning up... 03:25:37 INFO - Return code: 0 03:25:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:37 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 0x7f1032592f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, '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': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', '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 03:25:37 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 03:25:37 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 03:25:37 INFO - Using env: {'DISPLAY': ':0', 03:25:37 INFO - 'HOME': '/home/cltbld', 03:25:37 INFO - 'LANG': 'en_US.UTF-8', 03:25:37 INFO - 'LANGUAGE': 'en_US:en', 03:25:37 INFO - 'LOGNAME': 'cltbld', 03:25:37 INFO - 'MAIL': '/var/mail/cltbld', 03:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:37 INFO - 'MOZ_NO_REMOTE': '1', 03:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:37 INFO - 'NO_EM_RESTART': '1', 03:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:37 INFO - 'PWD': '/builds/slave/test', 03:25:37 INFO - 'SHELL': '/bin/bash', 03:25:37 INFO - 'SHLVL': '1', 03:25:37 INFO - 'TERM': 'linux', 03:25:37 INFO - 'TMOUT': '86400', 03:25:37 INFO - 'USER': 'cltbld', 03:25:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:37 INFO - '_': '/tools/buildbot/bin/python'} 03:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:38 INFO - Downloading/unpacking flake8 03:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:25:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:25:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 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 03:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:25:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:40 INFO - no previously-included directories found matching 'docs/_build' 03:25:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:25:40 INFO - Running setup.py install for pep8 03:25:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:40 INFO - no previously-included directories found matching 'docs/_build' 03:25:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:25:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:25:40 INFO - Cleaning up... 03:25:41 INFO - Return code: 0 03:25:41 INFO - Running post-action listener: _resource_record_post_action 03:25:41 INFO - Running post-action listener: _start_resource_monitoring 03:25:41 INFO - Starting resource monitoring. 03:25:41 INFO - ##### 03:25:41 INFO - ##### Finished create-virtualenv step (success) 03:25:41 INFO - ##### 03:25:41 INFO - ##### 03:25:41 INFO - ##### Running install step. 03:25:41 INFO - ##### 03:25:41 INFO - Running pre-action listener: _resource_record_pre_action 03:25:41 INFO - Running main action method: install 03:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:41 INFO - Reading from file tmpfile_stdout 03:25:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:41 INFO - Reading from file tmpfile_stdout 03:25:41 INFO - Output received: 03:25:41 INFO - Usage: mozinstall [options] installer 03:25:41 INFO - Options: 03:25:41 INFO - -h, --help show this help message and exit 03:25:41 INFO - -d DEST, --destination=DEST 03:25:41 INFO - Directory to install application into. [default: 03:25:41 INFO - "/builds/slave/test"] 03:25:41 INFO - --app=APP Application being installed. [default: firefox] 03:25:41 INFO - mkdir: /builds/slave/test/build/application 03:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:25:57 INFO - Reading from file tmpfile_stdout 03:25:57 INFO - Output received: 03:25:57 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:57 INFO - Running post-action listener: _resource_record_post_action 03:25:57 INFO - ##### 03:25:57 INFO - ##### Finished install step (success) 03:25:57 INFO - ##### 03:25:57 INFO - ##### 03:25:57 INFO - ##### Running run-tests step. 03:25:57 INFO - ##### 03:25:57 INFO - Running pre-action listener: _resource_record_pre_action 03:25:57 INFO - Running main action method: run_tests 03:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:57 INFO - Python 2.7.3 03:25:57 INFO - Return code: 0 03:25:57 INFO - grabbing minidump binary from tooltool 03:25: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')]} 03:25:57 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 0x160d1c0>, '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 0x160e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:57 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 03:25:57 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 03:25:57 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 03:25:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:57 INFO - Return code: 0 03:25:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:25:58 INFO - Return code: 0 03:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 03:25:58 INFO - Using env: {'DISPLAY': ':0', 03:25:58 INFO - 'HOME': '/home/cltbld', 03:25:58 INFO - 'LANG': 'en_US.UTF-8', 03:25:58 INFO - 'LANGUAGE': 'en_US:en', 03:25:58 INFO - 'LOGNAME': 'cltbld', 03:25:58 INFO - 'MAIL': '/var/mail/cltbld', 03:25:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:58 INFO - 'MOZ_NO_REMOTE': '1', 03:25:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:58 INFO - 'NO_EM_RESTART': '1', 03:25:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:58 INFO - 'PWD': '/builds/slave/test', 03:25:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:58 INFO - 'SHELL': '/bin/bash', 03:25:58 INFO - 'SHLVL': '1', 03:25:58 INFO - 'TERM': 'linux', 03:25:58 INFO - 'TMOUT': '86400', 03:25:58 INFO - 'USER': 'cltbld', 03:25:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033', 03:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:58 INFO - '_': '/tools/buildbot/bin/python'} 03:25:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:25:58 INFO - mozversion application_buildid: 20160624004013 03:25:58 INFO - mozversion application_changeset: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c 03:25:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:25:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:58 INFO - mozversion application_name: Firefox 03:25:58 INFO - mozversion application_remotingname: firefox-dev 03:25:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:58 INFO - mozversion application_vendor: Mozilla 03:25:58 INFO - mozversion application_version: 49.0a2 03:25:58 INFO - mozversion platform_buildid: 20160624004013 03:25:58 INFO - mozversion platform_changeset: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c 03:25:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:58 INFO - mozversion platform_version: 49.0a2 03:25:58 INFO - using testdate: 1466763958 03:25:58 INFO - actual date: 1466763958 03:25:58 INFO - starting webserver on 'localhost:40079' 03:25:58 INFO - SUITE-START | Running 2 tests 03:25:58 INFO - TEST-START | dromaeo_css 03:25:58 INFO - operating with platform_type : linux_ 03:25:58 INFO - Initialising browser for dromaeo_css test... 03:25:58 INFO - TEST-INFO | started process 8863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrTVJG/profile http://localhost:40079/getInfo.html) 03:26:03 INFO - PROCESS | 8863 | __metrics Screen width/height:1600/1200 03:26:03 INFO - PROCESS | 8863 | colorDepth:24 03:26:03 INFO - PROCESS | 8863 | Browser inner width/height: 1024/697 03:26:03 INFO - PROCESS | 8863 | __metrics 03:26:03 ERROR - PROCESS | 8863 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:26:04 INFO - TEST-INFO | 8863: exit 0 03:26:04 INFO - Browser initialized. 03:26:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:04 INFO - TEST-INFO | started process 8992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrTVJG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:16 INFO - PROCESS | 8992 | RSS: Main: 156061696 03:26:16 INFO - PROCESS | 8992 | 03:27:05 INFO - PROCESS | 8992 | 1466764025813 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] 03:29:13 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40079/tests/dromaeo/cssquery-ext.html) 03:29:14 INFO - PROCESS | 8992 | RSS: Main: 159989760 03:29:14 INFO - PROCESS | 8992 | 03:32:16 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-ext.html (next: http://localhost:40079/tests/dromaeo/cssquery-jquery.html) 03:32:17 INFO - PROCESS | 8992 | RSS: Main: 157564928 03:32:17 INFO - PROCESS | 8992 | 03:35:19 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40079/tests/dromaeo/cssquery-mootools.html) 03:35:19 INFO - PROCESS | 8992 | RSS: Main: 157302784 03:35:19 INFO - PROCESS | 8992 | 03:38:21 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40079/tests/dromaeo/cssquery-prototype.html) 03:38:22 INFO - PROCESS | 8992 | RSS: Main: 156585984 03:38:22 INFO - PROCESS | 8992 | 03:41:24 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40079/tests/dromaeo/cssquery-yui.html) 03:41:25 INFO - PROCESS | 8992 | RSS: Main: 158830592 03:41:25 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:40079/tests/dromaeo/cssquery-yui.html (next: http://localhost:40079/tests/dromaeo/cssquery-dojo.html) 03:44:27 INFO - PROCESS | 8992 | RSS: Main: 158633984 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | __start_tp_report 03:44:27 INFO - PROCESS | 8992 | _x_x_mozilla_page_load 03:44:27 INFO - PROCESS | 8992 | _x_x_mozilla_page_load_details 03:44:27 INFO - PROCESS | 8992 | |i|pagename|runs| 03:44:27 INFO - PROCESS | 8992 | |0;dojo.html;3397.677220664036;3405.3359594879007;3427.3659373015994;3448.6551344865516;3449.2239246169615;5627.071533197022;5674.09214525676;5686.488216060554;5693.914591281134;5713.257276554042;5663.093904975205;5693.459121383472;5740.282464691913;5749.281339832521;5753;5104.617153713468;5171.405288391827;5195.948040519603;5255.264263003182;5261.263423120747;5139.126348520742;5143.742812859361;5273.077211487994;5273.235380869791;5274.235235890794;5170.793168273283;5190.273361729361;5202.791888324481;5207.557357624606;5234.973825130869;5213.530782229599;5278.2610434539;5287.576993840484;5292.841214763564;5323.920141197885;5046.268291097807;5133.820316288912;5205.453427390107;5251.947480525222;5283.207518872162;5460.863478413032;5597.80407685729;5609.467100625434;5673.744681489343;5681.971590142064;6157.630542167484;6198.659073750942;6202.534809889276;6211.223597050369;6221.284552276501;5917.940820591782;6052.909206361908;6250.718717657716;6258.34287399821;6277.811665650038;5686.431356864322;5743.4543718346695;5744.856378590569;5750.568707346965;5785.363610002896;6228.626282423069;6261.592996455216;6272.153259310026;6280.654563999024;6291.307956124822;5827.737751801179;5934.465898069195;5951.256092988377;5997.730102145414;6007.429294217042;6108.821145689946;6111.227117700271;6113.628337950562;6124.565059171836;6143.447089761943;6019.54853385989;6055.182550355734;6069.666168360694;6078.361772013964;6091.878162436727;5911.615744976562;5982;6034.637921724623;6044.304904935989;6076.270847498328;4644.047970166108;4649.674522783373;4655.371524844103;4656.4877863434995;4685.976570117127;4158.9376159357025;4183.372494125905;4197.370394440858;4203.180379825966;4235.2800023996;5751.482366587027;5766.971165144148;5789.421057894261;5798.391168927202;5860.736266868002;6081.27024757032;6089.238845144357;6093.421124993119;6191.566590338633;6199.535034872402;5783.727579932408;5886.705664716833;5888.3228428731245;5904.793332233351;5905.232319798399;5294.8941021180135;5323.1749078892835;5346.1713434417725;5377.758000889891;5383.650062745909;6425.261094974137;6425.646589437626;6452.612843229421;6459;6469.676516174172;5900.498457630978;6067.271927368744;6238.875222495525;6252.812415627538;6259.874802504016;6214.751409943552;6317.936820631735;6341.048842673636;6348.396902294275;6351;5948.839976204772;5997.650528631023;6009.849753756191;6012.969935150296;6016.699165041818;6027.336992930862;6043.244594425697;6072.8785424292155;6114;6132.386761323832;5969.313528944227;6000.069989151689;6030.065339872327;6030.969845150922;6042.667653278936;6005.309389420097;6011.947909115975;6023.397660233942;6023.668698221464;6033.276006879202;5749.54003679713;5789.797357092481;5793.044147715748;5799.5070419014855;5841.883162336814;5924.31870334917;5928;5960.046392577166;5964.075568286922;5972.432618901197;5774.884502310014;5853.531717462678;5873.442023007808;5883.441073098049;5886.440788125121 03:44:27 INFO - PROCESS | 8992 | |1;ext.html;592.964422134672;626.523841880171;644.4940721533595;648.8215740671318;658.0721183131785;34550;37621.81189094054;46587.068258634805;47116.76441617795;47291.52708472914;49289.50710492894;49760.75119624397;49827;49846.75076624621;49891;9167.037461066575;9250.907490925072;9310.068993100704;9311.580978855935;9315.928668203142;9086.954565227197;9159.587818548149;9168.816623667522;9173.724788256362;9189.540522973857;9209.263258939302;9212.769680758001;9228.123328283837;9251.53742312885;9290.814183716322;9148.954255228715;9165.679201227958;9218.907810921872;9239.214666753334;9239.72280831576;9166.129217724372;9172;9191.862122068174;9195.448273103635;9215.953920230357;44793.10413791706;44929;44978.550214497765;45133.09733805338;45197.096058078656;3841.7310788244836;3860.8455661773496;4053.169100334454;4066.3087275163293;4522.982328975987;34810.47784283238;35379.469307960404;35415.4687679685;35535;35590.64409355899;4666.53334666534;4744.359511465942;4747.905041899177;4749.905001899942;4819.469858315582;384028;387483.9999999972;387879;390787;391539;61471.69264153651;61581.38418615846;61714.69142654258;61733.69133154306;61756;39242.21515569673;39953.80023099924;40109;41875.7906210467;64168.67915660485;19574.119164637625;19861.106250218774;19905.402837914884;19960.800391995894;20021.499462513264;14370.13779173253;14378.424863005363;14386.208758518173;14460.276986150651;14490.492832751013;20950.37148885536;21132.366029019155;21182.15271389127;21302.680459793115;21308.57382852365;7458.70165193397;7510.586917719468;7657.387409007266;7687.192844751333;7727.343175830118;1053.599632139782;1145.8109411947103;1150.764093360859;1194.2476239968764;1195.4739914437619;32876.50685239724;33303.3339333212;33873.830630846685;36508.26983460316;37096.258074838894;1176.7940610393148;1185.3658292813304;1207.8792120788028;1278.1053262716136;1282.9294388808705;17335.133243337783;17494.562635934202;17611.952175383514;17912.641747164984;18013.639727205646;667561;1106970;1120445;1127761;1134346;62713;63724.36275637277;63763.36236637667;63855.680721596094;63950;1506;1507.1559926441228;1510.5090845475265;1511.847797342531;1532.073095777061;32818.67181328156;33085.33829323352;33329;33804.66195338015;34252.657473424944;53243.73378133085;53402.19896701475;53664.19503707525;53892;53933.460665394414;429614;430841;432578;432767;434290;46766.532334676216;46783.06433871372;47612.2858157121;47731;47896.04207915892;51351.743241283555;51370;51439.22841157311;52280.21579676232;52291;42310.36534452047;43270.78364608157;43453.78273108614;44325.55674443214;44388.112237754416;41815.58184418117;41817.372739408325;43072.56927430686;43725;43744.78127609342;43724.78137609291;43823.56176438195;44675.77662111669;45459.31811022903;46225.306620401396;39342.21315573615;39402.40896386499;39905.2018959625;40386;40665.796671016455;29358.41283174282;29572.997396690298;30108.247293816952;30403.2399190022;30609 03:44:27 INFO - PROCESS | 8992 | |2;jquery.html;400.45538068227216;401.7348549957029;403.20568480094215;404.99595004049985;425.0330498116784;18317.816821831777;19610.90194549029;20115.497112572175;20198.798012019877;20425.489362765937;18138.093095345244;18145.364912228073;18331.633367332677;19340.903295483502;20007.799922000777;5637.520810731083;5681.943180568203;5690.118031705092;5834.6790926499025;5838.562107841907;5706.885862282773;5759.4816466518005;5771;5774.942250577483;5776.59563830532;5553.639013464132;5655.123455864347;5697.259356283677;5705.5435565154685;5733.140028995663;5702.173184888209;5715.485606295411;5716.1711551825165;5729.28383952006;5750.252467179261;4928.285398617216;5030.170021946375;5061.16490779021;5089.618278629081;5105.310783044279;23319.417014574603;23328.183513576943;23536.411589710224;24168.637470437956;24275.87862060696;2303.8156947444163;2353.1528649686097;2423.3214699883883;2506.1854897158496;2660.5743081107125;14516.491922782652;15038.248087595577;15055.623609409742;15260.084394936339;15386.384544618202;1847.1410793980863;1888.8583356248337;1894.0908363985227;1898.9525261868425;1899.3162461513843;65127.348726513075;80898;81077.59461202656;82524;88984.55507722485;10903;11063.506426632302;11070.501827417786;11245.269057511236;11247.775044499063;15696.843031569766;15763.290651920692;15792.526224213292;15830.841691583168;15865.286062127232;9029.954850225839;9087.727368178965;9256.166944974984;9266.397684150643;9297.488638124833;9086.681966131153;9151.496667683208;9160.129787670161;9207.17135457812;9282.675106371245;6825;6983.2318444971015;7054.717811287491;7131.750388736473;7136.286371362822;1956.461972957448;1995.162031946586;2020.3332900143212;2042.8876411797494;2045.6522391193234;1029.2897900448665;1080.7892460970193;1083.3499900060058;1104.5857803323754;1159.907207423404;20078;20207.292744753864;20407;20780.688289675665;21052.368428947157;1085.8479812826054;1114.3369695031442;1127.4419162514607;1161.4657257661402;1161.8257261410688;11295.604653837076;11545.942270288595;11585.76828463426;11767.117466189899;11789.3515856627;493377;495590;507610;511721;514599;87909.56045219733;89189;89737;90167;91586.54206728924;1042.124615323117;1098.6045023791428;1102.7573933734566;1103.426218366461;1103.9172062095374;18589.628207436046;18725.595580331257;18762.624747505248;18900.716489252398;18989.05054747285;43622.127557449305;43836;44043.33934990913;45588.31617525806;46027.30959035684;63924.68037659782;64196.67901660649;64244.357556423834;64885.67557162184;66165.66917165383;7428.517146385468;7821.843563128819;8772.649094036167;8792.120787921156;9003.459792412476;9926.362150245417;13744.175349479063;14026.719465610835;14059.718805624036;14082.929585352007;11672.88327116718;12099.57651482194;12223.388830558259;12375.443105060114;12537.561185358469;11934.940325298317;12060.336681482602;12249;12329.876701232874;12442;12217.755644886875;12362.196457230251;12450.315232662291;12454.065945053975;12458.31479268649;8846;8942.284617230736;9029.593668284811;9202;9202.217811486098;9154.542272886461;11821.940890295493;11973;11993.40032998364;12110.878891211327 03:44:27 INFO - PROCESS | 8992 | |3;mootools.html;1517.4461321617605;1551.666391725779;1694.1698567701822;1835.5686413692772;1856.9693819929942;8653.091425400336;9169.128932751386;9218.492982885939;9775.462349570771;9797.608095676173;9319.813603727922;9608;9709.320347575673;9725.562349694263;9752.12230899219;2495.937601559962;2525.785308248801;2532.0757923357933;2532.4428625702317;2534.6831646044243;2486.365976675945;2541.682289713786;2542.7330130336327;2543.0082267915527;2543.36415896026;2434.196715084018;2468.3088735154097;2544.3384719972846;2546.7580579844885;2547.0575886921774;2307.746147923727;2310.2260742651233;2343.086196383412;2344.882755862217;2347.495288512969;2432.3311089450367;2444.828861979662;2457.680501534789;2477.0587176872855;2483.1557270528106;9624.51877406127;9639.662611808553;9727.027297270217;9745.12293893553;9776.413415195111;5625.240592519998;5718.771249150029;5753.6260143090985;5754.367019627837;5768;3373.1061268763797;3420.3672320620763;3508.3158784037123;3515.3320869035056;3537.593176784677;1113.6492005018392;1129.5481807277072;1156.670348950545;1159.3565571108031;1161.396074041502;13565.796513052312;13575.932120339336;13595.52415665447;13635.250061246628;13645.181289122684;4945.752712364368;4998.450170481244;5045.369328833895;5088;5148.613853960968;11297.265677731086;11360.829587556193;11401.372924489233;11413.48639311233;11437.542498300141;5689.687067211343;5795.710214489259;5827.76688932438;5828.912566311508;5829.88340233193;4695.906081878412;5141.357330333708;5232.843014709565;5265.210218467184;5322.973385133049;4387.254166791653;4399.868003959887;4457.576530229623;4477.238869392211;4558.0428110097255;1296.494367196794;1317.157019507516;1318.7428451451874;1328.8538260791306;1345.172718777964;876.6449587916904;996.880374355082;1024.8513965474965;1064.8668916385452;1069.9304545204536;6279.434850863444;6334.841628959313;6384.7126879290545;6398.584092034003;6411.871762564722;472.1383475157851;477.164961317694;479.4773696670646;489.8310083021352;489.9020195960822;4386.912261754747;4396.670249731283;4440.977795111068;4442.089371678798;4478.798454069574;11649.825252621218;12042.698932526757;12135;12146.028317734561;12154.635360939186;11759.823602645967;11764.823527647091;11862.22895511789;11880.108991825648;11884.227525210834;8651.653933842575;8714.172153645393;8887.244584210286;8953.462792232487;9153.405028673249;6618.1065556151225;6853.211880633791;6875.106236189464;6901.413379862567;6933.341332573397;10951.288166269167;11090.944545277222;11106.333619982826;11175.441227938732;11218.158638102012;11294.491747871201;11347.773044538897;11424;11481.253718508271;11499.655010349703;8411.032731235986;8416.4950102994;8671.04618491978;8680;8716.084811094745;9398.154166125081;9484.478353690338;9486.288528360263;9526.523673816142;9530.285228607743;8207.71273005442;8469.61886715087;8501.93725784277;8532.488050716976;8713.215810577078;8083.191680832105;8127.431079824592;8547.188017138362;8552.358573106918;8631.91368086311;7737.767866964;7852.725154619561;7872.330851877655;7873;7876.803079923047;5297.073012222922;5378.784848606012;5405.378381486179;5471.808486703106;5559.694216818114;5472.26124473207;5497.532709719719;5563.5271001963665;5603.467670571289;5728.54171666274 03:44:27 INFO - PROCESS | 8992 | |4;prototype.html;343.19520723902446;346.33849347745803;353.98230088495586;363.73992595294374;366.081136347767;5673.723412232246;5762.481376676098;5801.564882633804;5866.3547009828935;5877.5297976161855;5671.291088613923;5675.943240567593;5689.146628005801;5740;5754.568407369454;4469.374287599739;4479.283314669654;4497.955020449803;4523.525029871849;4543.522930092342;4458.331250312447;4499.797509112082;4551.7724113794175;4553.749543775091;4557.680962332638;4415.448068991376;4420.624246938998;4440;4440.955590444087;4496.4829044659955;4460.531644177363;4483.775811209426;4487.730736155809;4487.8429254976245;4502.7973741181395;3973.264945985002;3977.76133431995;3989.900252493682;3992.2215168042244;4044.878653640366;5493.983613031562;5606.439356064402;5619.0895095667665;5635.351934527541;5672.234248376458;5154.175331946908;5224.791008359661;5226.137687281594;5232.2413250078525;5241.056609810233;5900.232969713909;6106.114613381079;6109.969450152721;6140.478059364959;6176.845578860564;4388.078503514266;4414.492333381638;4420.292753159479;4436.4676238851225;4437.2013037653205;6235.189425374672;6352.841178970517;6367.522435817286;6386.2336519617475;6450.935490645127;4411.669124815651;4485.775711214426;4520.638348932078;4532.484471118561;4547.090581883636;4584.3352713856975;4595.954040459553;4598.908021839611;4607.6313894889;4615.630749540029;5196.168613021974;5217.713025783618;5225.503577160163;5233.528982391603;5265.183896496049;5919.704014799329;5929.487980564928;6065.8180254592435;6090.634561926298;6124.5100391968535;1509.3660662521768;1534.5038587377442;1543.8224604170439;1550.7671401236043;1555.2068445092857;960.4141473701037;964.8890377606665;978.4618459847055;985.8521221816785;994.4878387630376;5162;5330.6278705975465;5354.54486368663;5371.194320851825;5383.788647554269;5493.478119578714;5602.551795856321;5623;5677.63095398806;5679.346875109332;5356.464353564613;5379.811706590251;5566.749496272597;5985.713071689607;6002.919474494633;3282.83585820708;3320.900372988814;3345.2974875275977;3358.7648864579733;3371.2077661749468;6267.435930766253;6431.935680643227;6524.902126468107;6542.476601871839;6591.703373348211;6382.8723425531225;6411.743530258737;6442.840288748071;6450.548461607643;6454.419102280724;6290.433860952445;6426.807195784134;6432.871342573122;6485.956923569061;6565.409113179837;6220.253569571681;6231.3145553988115;6275.6862156892885;6310.242770867525;6338.461230795434;6178.382161783966;6194.163787888758;6200.472959798468;6200.945839207256;6239.5008399327035;6295.307516173126;6523.64119973406;6534.268418869098;6539.836504087436;6541.967290163519;4526.411566496335;4554.772261386851;4574.336721175345;4583.449986001701;4590.924080865761;6080.939190608037;6273.807976484453;6288.591241569284;6303.590266632654;6351.587146835441;6084;6113.174721412553;6118.9291873922775;6150.846228844136;6200.379962003944;6032.75868965254;6045.486133678511;6096.298925623432;6152.107944347955;6159.168512250789;5996.850078748066;6010.549208809444;6018;6035.577509574287;6051.576389652682;6144.218176728878;6169.691515424301;6180.907286390618;6187.690615469119;6192.59748116371;5887.293524776883;6036.3058248302;6103.11504831788;6104.633721976696;6120.877582448237 03:44:27 INFO - PROCESS | 8992 | |5;yui.html;707.4870718728922;759.525296689569;884.5665623844317;916.9083091690827;918.0635751533435;15140.167290799016;16126.354945802183;16245.756313655305;16337.183140842955;16398.590035249126;16288.348466061372;16453;16486.25811838467;16496.917515412435;16598.336066557353;713.4898547538509;827.7847759582522;855.3328403845011;857.1043259793531;859.4800145911727;855.5593869157389;862.4092496639822;864.3387808326635;865.3207232322628;865.8960924689046;918.9494577798218;923.0400383601046;925.0148591749798;925.1534845616253;928.2388441477991;908.9772755681095;912.3066469483207;914.2822884036033;914.5335878701877;915.9358844880861;673.2863165045068;675.5710124071201;676.7462201674372;679.5175425447937;680.7141000779684;15926.442574509952;15953;16000.359985600679;16119.758203626954;16128.112953787655;13960.371783269675;14372.281385930766;14537.636559086002;15068.54794356171;15215;13898.444062237499;14332.06841555306;14417.71164576713;14550.272486375745;14652.780208296885;4825;4845.152098382804;4853.587445067174;4867.3915760529935;5033.320501732256;81138.59430702867;83134.58432707858;83176;83429.16570834274;83621.58189209076;12065.577704780291;12094.637160885188;12307.815382769266;12318.50725970969;12404.875951240372;19254.422367329003;19313.324033658755;19321.130549125322;19327.710084348746;19327.710084348746;7805.960970195226;7811.296983271533;7869.803254918673;7977.321927636216;8365.623546940402;4664.067186562701;4693.78877950493;4720.386349774576;5108.233764935215;5208.088584497697;3733;3931.5478719947;3956.3867600521967;3959.3269144245546;3963.980180099081;674.5312008154384;687.6424259385192;689.5552368722147;690.9550879192836;691.8201267670441;763.2596381509926;764.2586690909809;815.135955886762;823.1028179284608;848.2747251100344;10739.301945373525;10917.945410272898;11131.944340278247;11180.273282236629;11275.590551181102;728.65024788102;729.5185177782638;783.2285199078902;805.8871757953891;824.3981893217984;4718.079974405026;4825.420949486084;4842.7336496493035;5059.645824792303;5077.949220507821;74526.62736686281;74791.62604187054;76993;77652.61173694208;77930;79860;106551.46724266329;107485.46257268664;108564.4571777136;109915.45042274738;91092;91961.5401922986;92194;92816;93584;9714.077162669535;9800.558974846292;9850;9857.901420985698;9875.555599997873;45178;47499.52500475089;49455;54398.45601543934;55215;76866;77493.61253193923;79518.6024069876;81725.59137204276;82013.17986820056;13723.382447790073;13833;13880.305984700926;14075.718485630436;14146.080504767157;14762.63093422673;15501.612459688598;15639.765403518728;15778.68442631164;15856.365745370056;13399.598012059654;13798.862011379757;14122.576322710334;14151.504697335955;14188.574342769733;14180;14590.270486475421;14974.101553906801;14979.101253924799;15100.39598416051;14161.079529830527;14364.928175359057;14702.852971470149;14816.62958426048;15624.531264062096;12001.459934303151;12479.31363775001;12523.93738031304;12559.748805024032;12980.610581682564;11848.052155827341;12061.15571909993;12136.696582585153;12173.69565760863;12241.143119981873 03:44:27 INFO - PROCESS | 8992 | __end_tp_report 03:44:27 INFO - PROCESS | 8992 | __start_cc_report 03:44:27 INFO - PROCESS | 8992 | _x_x_mozilla_cycle_collect,352 03:44:27 INFO - PROCESS | 8992 | __end_cc_report 03:44:27 INFO - PROCESS | 8992 | __startTimestamp1466765067781__endTimestamp 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | ------- Summary: start ------- 03:44:27 INFO - PROCESS | 8992 | Number of tests: 6 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#0] dojo.html Cycles:165 Average:5685.40 Median:5886.71 stddev:630.52 (10.7%) stddev-sans-first:606.37 03:44:27 INFO - PROCESS | 8992 | Values: 3397.7 3405.3 3427.4 3448.7 3449.2 5627.1 5674.1 5686.5 5693.9 5713.3 5663.1 5693.5 5740.3 5749.3 5753.0 5104.6 5171.4 5195.9 5255.3 5261.3 5139.1 5143.7 5273.1 5273.2 5274.2 5170.8 5190.3 5202.8 5207.6 5235.0 5213.5 5278.3 5287.6 5292.8 5323.9 5046.3 5133.8 5205.5 5251.9 5283.2 5460.9 5597.8 5609.5 5673.7 5682.0 6157.6 6198.7 6202.5 6211.2 6221.3 5917.9 6052.9 6250.7 6258.3 6277.8 5686.4 5743.5 5744.9 5750.6 5785.4 6228.6 6261.6 6272.2 6280.7 6291.3 5827.7 5934.5 5951.3 5997.7 6007.4 6108.8 6111.2 6113.6 6124.6 6143.4 6019.5 6055.2 6069.7 6078.4 6091.9 5911.6 5982.0 6034.6 6044.3 6076.3 4644.0 4649.7 4655.4 4656.5 4686.0 4158.9 4183.4 4197.4 4203.2 4235.3 5751.5 5767.0 5789.4 5798.4 5860.7 6081.3 6089.2 6093.4 6191.6 6199.5 5783.7 5886.7 5888.3 5904.8 5905.2 5294.9 5323.2 5346.2 5377.8 5383.7 6425.3 6425.6 6452.6 6459.0 6469.7 5900.5 6067.3 6238.9 6252.8 6259.9 6214.8 6317.9 6341.0 6348.4 6351.0 5948.8 5997.7 6009.8 6013.0 6016.7 6027.3 6043.2 6072.9 6114.0 6132.4 5969.3 6000.1 6030.1 6031.0 6042.7 6005.3 6011.9 6023.4 6023.7 6033.3 5749.5 5789.8 5793.0 5799.5 5841.9 5924.3 5928.0 5960.0 5964.1 5972.4 5774.9 5853.5 5873.4 5883.4 5886.4 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#1] ext.html Cycles:180 Average:76582.75 Median:43724.89 stddev:187689.49 (429.3%) stddev-sans-first:188129.29 03:44:27 INFO - PROCESS | 8992 | Values: 593.0 626.5 644.5 648.8 658.1 34550.0 37621.8 46587.1 47116.8 47291.5 49289.5 49760.8 49827.0 49846.8 49891.0 9167.0 9250.9 9310.1 9311.6 9315.9 9087.0 9159.6 9168.8 9173.7 9189.5 9209.3 9212.8 9228.1 9251.5 9290.8 9149.0 9165.7 9218.9 9239.2 9239.7 9166.1 9172.0 9191.9 9195.4 9216.0 44793.1 44929.0 44978.6 45133.1 45197.1 3841.7 3860.8 4053.2 4066.3 4523.0 34810.5 35379.5 35415.5 35535.0 35590.6 4666.5 4744.4 4747.9 4749.9 4819.5 384028.0 387484.0 387879.0 390787.0 391539.0 61471.7 61581.4 61714.7 61733.7 61756.0 39242.2 39953.8 40109.0 41875.8 64168.7 19574.1 19861.1 19905.4 19960.8 20021.5 14370.1 14378.4 14386.2 14460.3 14490.5 20950.4 21132.4 21182.2 21302.7 21308.6 7458.7 7510.6 7657.4 7687.2 7727.3 1053.6 1145.8 1150.8 1194.2 1195.5 32876.5 33303.3 33873.8 36508.3 37096.3 1176.8 1185.4 1207.9 1278.1 1282.9 17335.1 17494.6 17612.0 17912.6 18013.6 667561.0 1106970.0 1120445.0 1127761.0 1134346.0 62713.0 63724.4 63763.4 63855.7 63950.0 1506.0 1507.2 1510.5 1511.8 1532.1 32818.7 33085.3 33329.0 33804.7 34252.7 53243.7 53402.2 53664.2 53892.0 53933.5 429614.0 430841.0 432578.0 432767.0 434290.0 46766.5 46783.1 47612.3 47731.0 47896.0 51351.7 51370.0 51439.2 52280.2 52291.0 42310.4 43270.8 43453.8 44325.6 44388.1 41815.6 41817.4 43072.6 43725.0 43744.8 43724.8 43823.6 44675.8 45459.3 46225.3 39342.2 39402.4 39905.2 40386.0 40665.8 29358.4 29573.0 30108.2 30403.2 30609.0 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#2] jquery.html Cycles:180 Average:30015.77 Median:12840.67 stddev:83063.17 (646.9%) stddev-sans-first:83266.42 03:44:27 INFO - PROCESS | 8992 | Values: 400.5 401.7 403.2 405.0 425.0 18317.8 19610.9 20115.5 20198.8 20425.5 18138.1 18145.4 18331.6 19340.9 20007.8 5637.5 5681.9 5690.1 5834.7 5838.6 5706.9 5759.5 5771.0 5774.9 5776.6 5553.6 5655.1 5697.3 5705.5 5733.1 5702.2 5715.5 5716.2 5729.3 5750.3 4928.3 5030.2 5061.2 5089.6 5105.3 23319.4 23328.2 23536.4 24168.6 24275.9 2303.8 2353.2 2423.3 2506.2 2660.6 14516.5 15038.2 15055.6 15260.1 15386.4 1847.1 1888.9 1894.1 1899.0 1899.3 65127.3 80898.0 81077.6 82524.0 88984.6 10903.0 11063.5 11070.5 11245.3 11247.8 15696.8 15763.3 15792.5 15830.8 15865.3 9030.0 9087.7 9256.2 9266.4 9297.5 9086.7 9151.5 9160.1 9207.2 9282.7 6825.0 6983.2 7054.7 7131.8 7136.3 1956.5 1995.2 2020.3 2042.9 2045.7 1029.3 1080.8 1083.3 1104.6 1159.9 20078.0 20207.3 20407.0 20780.7 21052.4 1085.8 1114.3 1127.4 1161.5 1161.8 11295.6 11545.9 11585.8 11767.1 11789.4 493377.0 495590.0 507610.0 511721.0 514599.0 87909.6 89189.0 89737.0 90167.0 91586.5 1042.1 1098.6 1102.8 1103.4 1103.9 18589.6 18725.6 18762.6 18900.7 18989.1 43622.1 43836.0 44043.3 45588.3 46027.3 63924.7 64196.7 64244.4 64885.7 66165.7 7428.5 7821.8 8772.6 8792.1 9003.5 9926.4 13744.2 14026.7 14059.7 14082.9 11672.9 12099.6 12223.4 12375.4 12537.6 11934.9 12060.3 12249.0 12329.9 12442.0 12217.8 12362.2 12450.3 12454.1 12458.3 8846.0 8942.3 9029.6 9202.0 9202.2 9154.5 11821.9 11973.0 11993.4 12110.9 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#3] mootools.html Cycles:180 Average:6330.64 Median:478.32 stddev:3681.99 (769.8%) stddev-sans-first:3674.55 03:44:27 INFO - PROCESS | 8992 | Values: 1517.4 1551.7 1694.2 1835.6 1857.0 8653.1 9169.1 9218.5 9775.5 9797.6 9319.8 9608.0 9709.3 9725.6 9752.1 2495.9 2525.8 2532.1 2532.4 2534.7 2486.4 2541.7 2542.7 2543.0 2543.4 2434.2 2468.3 2544.3 2546.8 2547.1 2307.7 2310.2 2343.1 2344.9 2347.5 2432.3 2444.8 2457.7 2477.1 2483.2 9624.5 9639.7 9727.0 9745.1 9776.4 5625.2 5718.8 5753.6 5754.4 5768.0 3373.1 3420.4 3508.3 3515.3 3537.6 1113.6 1129.5 1156.7 1159.4 1161.4 13565.8 13575.9 13595.5 13635.3 13645.2 4945.8 4998.5 5045.4 5088.0 5148.6 11297.3 11360.8 11401.4 11413.5 11437.5 5689.7 5795.7 5827.8 5828.9 5829.9 4695.9 5141.4 5232.8 5265.2 5323.0 4387.3 4399.9 4457.6 4477.2 4558.0 1296.5 1317.2 1318.7 1328.9 1345.2 876.6 996.9 1024.9 1064.9 1069.9 6279.4 6334.8 6384.7 6398.6 6411.9 472.1 477.2 479.5 489.8 489.9 4386.9 4396.7 4441.0 4442.1 4478.8 11649.8 12042.7 12135.0 12146.0 12154.6 11759.8 11764.8 11862.2 11880.1 11884.2 8651.7 8714.2 8887.2 8953.5 9153.4 6618.1 6853.2 6875.1 6901.4 6933.3 10951.3 11090.9 11106.3 11175.4 11218.2 11294.5 11347.8 11424.0 11481.3 11499.7 8411.0 8416.5 8671.0 8680.0 8716.1 9398.2 9484.5 9486.3 9526.5 9530.3 8207.7 8469.6 8501.9 8532.5 8713.2 8083.2 8127.4 8547.2 8552.4 8631.9 7737.8 7852.7 7872.3 7873.0 7876.8 5297.1 5378.8 5405.4 5471.8 5559.7 5472.3 5497.5 5563.5 5603.5 5728.5 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#4] prototype.html Cycles:180 Average:5108.37 Median:5684.25 stddev:1504.52 (26.5%) stddev-sans-first:1465.61 03:44:27 INFO - PROCESS | 8992 | Values: 343.2 346.3 354.0 363.7 366.1 5673.7 5762.5 5801.6 5866.4 5877.5 5671.3 5675.9 5689.1 5740.0 5754.6 4469.4 4479.3 4498.0 4523.5 4543.5 4458.3 4499.8 4551.8 4553.7 4557.7 4415.4 4420.6 4440.0 4441.0 4496.5 4460.5 4483.8 4487.7 4487.8 4502.8 3973.3 3977.8 3989.9 3992.2 4044.9 5494.0 5606.4 5619.1 5635.4 5672.2 5154.2 5224.8 5226.1 5232.2 5241.1 5900.2 6106.1 6110.0 6140.5 6176.8 4388.1 4414.5 4420.3 4436.5 4437.2 6235.2 6352.8 6367.5 6386.2 6450.9 4411.7 4485.8 4520.6 4532.5 4547.1 4584.3 4596.0 4598.9 4607.6 4615.6 5196.2 5217.7 5225.5 5233.5 5265.2 5919.7 5929.5 6065.8 6090.6 6124.5 1509.4 1534.5 1543.8 1550.8 1555.2 960.4 964.9 978.5 985.9 994.5 5162.0 5330.6 5354.5 5371.2 5383.8 5493.5 5602.6 5623.0 5677.6 5679.3 5356.5 5379.8 5566.7 5985.7 6002.9 3282.8 3320.9 3345.3 3358.8 3371.2 6267.4 6431.9 6524.9 6542.5 6591.7 6382.9 6411.7 6442.8 6450.5 6454.4 6290.4 6426.8 6432.9 6486.0 6565.4 6220.3 6231.3 6275.7 6310.2 6338.5 6178.4 6194.2 6200.5 6200.9 6239.5 6295.3 6523.6 6534.3 6539.8 6542.0 4526.4 4554.8 4574.3 4583.4 4590.9 6080.9 6273.8 6288.6 6303.6 6351.6 6084.0 6113.2 6118.9 6150.8 6200.4 6032.8 6045.5 6096.3 6152.1 6159.2 5996.9 6010.5 6018.0 6035.6 6051.6 6144.2 6169.7 6180.9 6187.7 6192.6 5887.3 6036.3 6103.1 6104.6 6120.9 03:44:27 INFO - PROCESS | 8992 | 03:44:27 INFO - PROCESS | 8992 | [#5] yui.html Cycles:180 Average:20700.81 Median:4825.21 stddev:28357.30 (587.7%) stddev-sans-first:28397.11 03:44:27 INFO - PROCESS | 8992 | Values: 707.5 759.5 884.6 916.9 918.1 15140.2 16126.4 16245.8 16337.2 16398.6 16288.3 16453.0 16486.3 16496.9 16598.3 713.5 827.8 855.3 857.1 859.5 855.6 862.4 864.3 865.3 865.9 918.9 923.0 925.0 925.2 928.2 909.0 912.3 914.3 914.5 915.9 673.3 675.6 676.7 679.5 680.7 15926.4 15953.0 16000.4 16119.8 16128.1 13960.4 14372.3 14537.6 15068.5 15215.0 13898.4 14332.1 14417.7 14550.3 14652.8 4825.0 4845.2 4853.6 4867.4 5033.3 81138.6 83134.6 83176.0 83429.2 83621.6 12065.6 12094.6 12307.8 12318.5 12404.9 19254.4 19313.3 19321.1 19327.7 19327.7 7806.0 7811.3 7869.8 7977.3 8365.6 4664.1 4693.8 4720.4 5108.2 5208.1 3733.0 3931.5 3956.4 3959.3 3964.0 674.5 687.6 689.6 691.0 691.8 763.3 764.3 815.1 823.1 848.3 10739.3 10917.9 11131.9 11180.3 11275.6 728.7 729.5 783.2 805.9 824.4 4718.1 4825.4 4842.7 5059.6 5077.9 74526.6 74791.6 76993.0 77652.6 77930.0 79860.0 106551.5 107485.5 108564.5 109915.5 91092.0 91961.5 92194.0 92816.0 93584.0 9714.1 9800.6 9850.0 9857.9 9875.6 45178.0 47499.5 49455.0 54398.5 55215.0 76866.0 77493.6 79518.6 81725.6 82013.2 13723.4 13833.0 13880.3 14075.7 14146.1 14762.6 15501.6 15639.8 15778.7 15856.4 13399.6 13798.9 14122.6 14151.5 14188.6 14180.0 14590.3 14974.1 14979.1 15100.4 14161.1 14364.9 14702.9 14816.6 15624.5 12001.5 12479.3 12523.9 12559.7 12980.6 11848.1 12061.2 12136.7 12173.7 12241.1 03:44:27 INFO - PROCESS | 8992 | -------- Summary: end -------- 03:44:27 INFO - PROCESS | 8992 | 03:44:28 INFO - TEST-INFO | 8992: exit 0 03:44:28 INFO - TEST-OK | dromaeo_css | took 1110044ms 03:44:28 INFO - TEST-START | kraken 03:44:28 INFO - operating with platform_type : linux_ 03:44:28 INFO - Initialising browser for kraken test... 03:44:28 INFO - TEST-INFO | started process 9245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuvRCxY/profile http://localhost:40079/getInfo.html) 03:44:32 INFO - PROCESS | 9245 | __metrics Screen width/height:1600/1200 03:44:32 INFO - PROCESS | 9245 | colorDepth:24 03:44:32 INFO - PROCESS | 9245 | Browser inner width/height: 1024/697 03:44:32 INFO - PROCESS | 9245 | __metrics 03:44:33 ERROR - PROCESS | 9245 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:44:34 INFO - TEST-INFO | 9245: exit 0 03:44:34 INFO - Browser initialized. 03:44:34 INFO - Running cycle 1/1 for kraken test... 03:44:34 INFO - TEST-INFO | started process 9377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuvRCxY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:46 INFO - PROCESS | 9377 | RSS: Main: 155807744 03:44:46 INFO - PROCESS | 9377 | 03:44:48 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40079/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:49 INFO - PROCESS | 9377 | RSS: Main: 161021952 03:44:49 INFO - PROCESS | 9377 | 03:44:52 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40079/tests/kraken/driver.html?testName=audio-dft) 03:44:52 INFO - PROCESS | 9377 | RSS: Main: 160407552 03:44:52 INFO - PROCESS | 9377 | 03:44:55 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40079/tests/kraken/driver.html?testName=audio-fft) 03:44:56 INFO - PROCESS | 9377 | RSS: Main: 161591296 03:44:56 INFO - PROCESS | 9377 | 03:44:58 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40079/tests/kraken/driver.html?testName=audio-oscillator) 03:44:59 INFO - PROCESS | 9377 | RSS: Main: 160690176 03:44:59 INFO - PROCESS | 9377 | 03:45:01 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:01 INFO - PROCESS | 9377 | RSS: Main: 160800768 03:45:01 INFO - PROCESS | 9377 | 03:45:04 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40079/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:05 INFO - PROCESS | 9377 | RSS: Main: 160436224 03:45:05 INFO - PROCESS | 9377 | 03:45:09 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40079/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:09 INFO - PROCESS | 9377 | RSS: Main: 160694272 03:45:09 INFO - PROCESS | 9377 | 03:45:12 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40079/tests/kraken/driver.html?testName=json-parse-financial) 03:45:13 INFO - PROCESS | 9377 | RSS: Main: 161050624 03:45:13 INFO - PROCESS | 9377 | 03:45:14 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:15 INFO - PROCESS | 9377 | RSS: Main: 160833536 03:45:15 INFO - PROCESS | 9377 | 03:45:17 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:17 INFO - PROCESS | 9377 | RSS: Main: 161165312 03:45:17 INFO - PROCESS | 9377 | 03:45:19 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:20 INFO - PROCESS | 9377 | RSS: Main: 160940032 03:45:20 INFO - PROCESS | 9377 | 03:45:22 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:23 INFO - PROCESS | 9377 | RSS: Main: 161222656 03:45:23 INFO - PROCESS | 9377 | 03:45:26 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:26 INFO - PROCESS | 9377 | RSS: Main: 161341440 03:45:26 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | Cycle 1(1): loaded http://localhost:40079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40079/tests/kraken/driver.html?testName=ai-astar) 03:45:28 INFO - PROCESS | 9377 | RSS: Main: 161927168 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | __start_tp_report 03:45:28 INFO - PROCESS | 9377 | _x_x_mozilla_page_load 03:45:28 INFO - PROCESS | 9377 | _x_x_mozilla_page_load_details 03:45:28 INFO - PROCESS | 9377 | |i|pagename|runs| 03:45:28 INFO - PROCESS | 9377 | |0;ai-astar;111;106;110;109;111;113;110;110;111;111 03:45:28 INFO - PROCESS | 9377 | |1;audio-beat-detection;155;127;156;175;125;149;156;134;176;130 03:45:28 INFO - PROCESS | 9377 | |2;audio-dft;162;163;162;162;165;161;171;162;166;162 03:45:28 INFO - PROCESS | 9377 | |3;audio-fft;75;74;77;167;75;75;74;75;168;74 03:45:28 INFO - PROCESS | 9377 | |4;audio-oscillator;85;85;149;85;85;85;140;84;85;152 03:45:28 INFO - PROCESS | 9377 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 03:45:28 INFO - PROCESS | 9377 | |6;imaging-darkroom;147;147;147;147;148;147;148;146;147;147 03:45:28 INFO - PROCESS | 9377 | |7;imaging-desaturate;96;95;105;95;103;101;98;101;95;96 03:45:28 INFO - PROCESS | 9377 | |8;json-parse-financial;53;51;58;54;52;55;52;52;52;52 03:45:28 INFO - PROCESS | 9377 | |9;json-stringify-tinderbox;59;60;60;59;59;60;59;60;59;59 03:45:28 INFO - PROCESS | 9377 | |10;stanford-crypto-aes;76;77;84;76;77;83;84;78;115;76 03:45:28 INFO - PROCESS | 9377 | |11;stanford-crypto-ccm;122;128;118;126;118;120;116;118;133;142 03:45:28 INFO - PROCESS | 9377 | |12;stanford-crypto-pbkdf2;160;160;162;169;158;157;153;157;154;156 03:45:28 INFO - PROCESS | 9377 | |13;stanford-crypto-sha256-iterative;64;63;65;65;68;61;65;61;62;60 03:45:28 INFO - PROCESS | 9377 | __end_tp_report 03:45:28 INFO - PROCESS | 9377 | __start_cc_report 03:45:28 INFO - PROCESS | 9377 | _x_x_mozilla_cycle_collect,874 03:45:28 INFO - PROCESS | 9377 | __end_cc_report 03:45:28 INFO - PROCESS | 9377 | __startTimestamp1466765128789__endTimestamp 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | ------- Summary: start ------- 03:45:28 INFO - PROCESS | 9377 | Number of tests: 14 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 03:45:28 INFO - PROCESS | 9377 | Values: 111.0 106.0 110.0 109.0 111.0 113.0 110.0 110.0 111.0 111.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.50 stddev:18.80 (12.1%) stddev-sans-first:19.78 03:45:28 INFO - PROCESS | 9377 | Values: 155.0 127.0 156.0 175.0 125.0 149.0 156.0 134.0 176.0 130.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.03 (1.9%) stddev-sans-first:3.15 03:45:28 INFO - PROCESS | 9377 | Values: 162.0 163.0 162.0 162.0 165.0 161.0 171.0 162.0 166.0 162.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:39.06 (52.1%) stddev-sans-first:40.86 03:45:28 INFO - PROCESS | 9377 | Values: 75.0 74.0 77.0 167.0 75.0 75.0 74.0 75.0 168.0 74.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:30.16 (35.5%) stddev-sans-first:31.24 03:45:28 INFO - PROCESS | 9377 | Values: 85.0 85.0 149.0 85.0 85.0 85.0 140.0 84.0 85.0 152.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:45:28 INFO - PROCESS | 9377 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:45:28 INFO - PROCESS | 9377 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 147.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:95.00 stddev:3.72 (3.9%) stddev-sans-first:3.83 03:45:28 INFO - PROCESS | 9377 | Values: 96.0 95.0 105.0 95.0 103.0 101.0 98.0 101.0 95.0 96.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.50 stddev:2.08 (4.0%) stddev-sans-first:2.20 03:45:28 INFO - PROCESS | 9377 | Values: 53.0 51.0 58.0 54.0 52.0 55.0 52.0 52.0 52.0 52.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:45:28 INFO - PROCESS | 9377 | Values: 59.0 60.0 60.0 59.0 59.0 60.0 59.0 60.0 59.0 59.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:77.50 stddev:11.87 (15.3%) stddev-sans-first:12.35 03:45:28 INFO - PROCESS | 9377 | Values: 76.0 77.0 84.0 76.0 77.0 83.0 84.0 78.0 115.0 76.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:8.28 (6.7%) stddev-sans-first:8.75 03:45:28 INFO - PROCESS | 9377 | Values: 122.0 128.0 118.0 126.0 118.0 120.0 116.0 118.0 133.0 142.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.00 stddev:4.58 (2.9%) stddev-sans-first:4.82 03:45:28 INFO - PROCESS | 9377 | Values: 160.0 160.0 162.0 169.0 158.0 157.0 153.0 157.0 154.0 156.0 03:45:28 INFO - PROCESS | 9377 | 03:45:28 INFO - PROCESS | 9377 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.50 stddev:2.46 (3.8%) stddev-sans-first:2.60 03:45:28 INFO - PROCESS | 9377 | Values: 64.0 63.0 65.0 65.0 68.0 61.0 65.0 61.0 62.0 60.0 03:45:28 INFO - PROCESS | 9377 | -------- Summary: end -------- 03:45:28 INFO - PROCESS | 9377 | 03:45:29 INFO - TEST-INFO | 9377: exit 0 03:45:29 INFO - TEST-OK | kraken | took 61303ms 03:45:29 INFO - SUITE-END | took 1171s 03:45:29 INFO - Completed test suite (00:19:31) 03:45:29 INFO - javascript benchmark 03:45:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7768.196967909249, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.677220664036, 3405.3359594879007, 3427.3659373015994, 3448.6551344865516, 3449.2239246169615, 5627.071533197022, 5674.09214525676, 5686.488216060554, 5693.914591281134, 5713.257276554042, 5663.093904975205, 5693.459121383472, 5740.282464691913, 5749.281339832521, 5753.0, 5104.617153713468, 5171.405288391827, 5195.948040519603, 5255.264263003182, 5261.263423120747, 5139.126348520742, 5143.742812859361, 5273.077211487994, 5273.235380869791, 5274.235235890794, 5170.793168273283, 5190.273361729361, 5202.791888324481, 5207.557357624606, 5234.973825130869, 5213.530782229599, 5278.2610434539, 5287.576993840484, 5292.841214763564, 5323.920141197885, 5046.268291097807, 5133.820316288912, 5205.453427390107, 5251.947480525222, 5283.207518872162, 5460.863478413032, 5597.80407685729, 5609.467100625434, 5673.744681489343, 5681.971590142064, 6157.630542167484, 6198.659073750942, 6202.534809889276, 6211.223597050369, 6221.284552276501, 5917.940820591782, 6052.909206361908, 6250.718717657716, 6258.34287399821, 6277.811665650038, 5686.431356864322, 5743.4543718346695, 5744.856378590569, 5750.568707346965, 5785.363610002896, 6228.626282423069, 6261.592996455216, 6272.153259310026, 6280.654563999024, 6291.307956124822, 5827.737751801179, 5934.465898069195, 5951.256092988377, 5997.730102145414, 6007.429294217042, 6108.821145689946, 6111.227117700271, 6113.628337950562, 6124.565059171836, 6143.447089761943, 6019.54853385989, 6055.182550355734, 6069.666168360694, 6078.361772013964, 6091.878162436727, 5911.615744976562, 5982.0, 6034.637921724623, 6044.304904935989, 6076.270847498328, 4644.047970166108, 4649.674522783373, 4655.371524844103, 4656.4877863434995, 4685.976570117127, 4158.9376159357025, 4183.372494125905, 4197.370394440858, 4203.180379825966, 4235.2800023996, 5751.482366587027, 5766.971165144148, 5789.421057894261, 5798.391168927202, 5860.736266868002, 6081.27024757032, 6089.238845144357, 6093.421124993119, 6191.566590338633, 6199.535034872402, 5783.727579932408, 5886.705664716833, 5888.3228428731245, 5904.793332233351, 5905.232319798399, 5294.8941021180135, 5323.1749078892835, 5346.1713434417725, 5377.758000889891, 5383.650062745909, 6425.261094974137, 6425.646589437626, 6452.612843229421, 6459.0, 6469.676516174172, 5900.498457630978, 6067.271927368744, 6238.875222495525, 6252.812415627538, 6259.874802504016, 6214.751409943552, 6317.936820631735, 6341.048842673636, 6348.396902294275, 6351.0, 5948.839976204772, 5997.650528631023, 6009.849753756191, 6012.969935150296, 6016.699165041818, 6027.336992930862, 6043.244594425697, 6072.8785424292155, 6114.0, 6132.386761323832, 5969.313528944227, 6000.069989151689, 6030.065339872327, 6030.969845150922, 6042.667653278936, 6005.309389420097, 6011.947909115975, 6023.397660233942, 6023.668698221464, 6033.276006879202, 5749.54003679713, 5789.797357092481, 5793.044147715748, 5799.5070419014855, 5841.883162336814, 5924.31870334917, 5928.0, 5960.046392577166, 5964.075568286922, 5972.432618901197, 5774.884502310014, 5853.531717462678, 5873.442023007808, 5883.441073098049, 5886.440788125121], "value": 5644.479363438452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.964422134672, 626.523841880171, 644.4940721533595, 648.8215740671318, 658.0721183131785, 34550.0, 37621.81189094054, 46587.068258634805, 47116.76441617795, 47291.52708472914, 49289.50710492894, 49760.75119624397, 49827.0, 49846.75076624621, 49891.0, 9167.037461066575, 9250.907490925072, 9310.068993100704, 9311.580978855935, 9315.928668203142, 9086.954565227197, 9159.587818548149, 9168.816623667522, 9173.724788256362, 9189.540522973857, 9209.263258939302, 9212.769680758001, 9228.123328283837, 9251.53742312885, 9290.814183716322, 9148.954255228715, 9165.679201227958, 9218.907810921872, 9239.214666753334, 9239.72280831576, 9166.129217724372, 9172.0, 9191.862122068174, 9195.448273103635, 9215.953920230357, 44793.10413791706, 44929.0, 44978.550214497765, 45133.09733805338, 45197.096058078656, 3841.7310788244836, 3860.8455661773496, 4053.169100334454, 4066.3087275163293, 4522.982328975987, 34810.47784283238, 35379.469307960404, 35415.4687679685, 35535.0, 35590.64409355899, 4666.53334666534, 4744.359511465942, 4747.905041899177, 4749.905001899942, 4819.469858315582, 384028.0, 387483.9999999972, 387879.0, 390787.0, 391539.0, 61471.69264153651, 61581.38418615846, 61714.69142654258, 61733.69133154306, 61756.0, 39242.21515569673, 39953.80023099924, 40109.0, 41875.7906210467, 64168.67915660485, 19574.119164637625, 19861.106250218774, 19905.402837914884, 19960.800391995894, 20021.499462513264, 14370.13779173253, 14378.424863005363, 14386.208758518173, 14460.276986150651, 14490.492832751013, 20950.37148885536, 21132.366029019155, 21182.15271389127, 21302.680459793115, 21308.57382852365, 7458.70165193397, 7510.586917719468, 7657.387409007266, 7687.192844751333, 7727.343175830118, 1053.599632139782, 1145.8109411947103, 1150.764093360859, 1194.2476239968764, 1195.4739914437619, 32876.50685239724, 33303.3339333212, 33873.830630846685, 36508.26983460316, 37096.258074838894, 1176.7940610393148, 1185.3658292813304, 1207.8792120788028, 1278.1053262716136, 1282.9294388808705, 17335.133243337783, 17494.562635934202, 17611.952175383514, 17912.641747164984, 18013.639727205646, 667561.0, 1106970.0, 1120445.0, 1127761.0, 1134346.0, 62713.0, 63724.36275637277, 63763.36236637667, 63855.680721596094, 63950.0, 1506.0, 1507.1559926441228, 1510.5090845475265, 1511.847797342531, 1532.073095777061, 32818.67181328156, 33085.33829323352, 33329.0, 33804.66195338015, 34252.657473424944, 53243.73378133085, 53402.19896701475, 53664.19503707525, 53892.0, 53933.460665394414, 429614.0, 430841.0, 432578.0, 432767.0, 434290.0, 46766.532334676216, 46783.06433871372, 47612.2858157121, 47731.0, 47896.04207915892, 51351.743241283555, 51370.0, 51439.22841157311, 52280.21579676232, 52291.0, 42310.36534452047, 43270.78364608157, 43453.78273108614, 44325.55674443214, 44388.112237754416, 41815.58184418117, 41817.372739408325, 43072.56927430686, 43725.0, 43744.78127609342, 43724.78137609291, 43823.56176438195, 44675.77662111669, 45459.31811022903, 46225.306620401396, 39342.21315573615, 39402.40896386499, 39905.2018959625, 40386.0, 40665.796671016455, 29358.41283174282, 29572.997396690298, 30108.247293816952, 30403.2399190022, 30609.0], "value": 22030.697723988484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.45538068227216, 401.7348549957029, 403.20568480094215, 404.99595004049985, 425.0330498116784, 18317.816821831777, 19610.90194549029, 20115.497112572175, 20198.798012019877, 20425.489362765937, 18138.093095345244, 18145.364912228073, 18331.633367332677, 19340.903295483502, 20007.799922000777, 5637.520810731083, 5681.943180568203, 5690.118031705092, 5834.6790926499025, 5838.562107841907, 5706.885862282773, 5759.4816466518005, 5771.0, 5774.942250577483, 5776.59563830532, 5553.639013464132, 5655.123455864347, 5697.259356283677, 5705.5435565154685, 5733.140028995663, 5702.173184888209, 5715.485606295411, 5716.1711551825165, 5729.28383952006, 5750.252467179261, 4928.285398617216, 5030.170021946375, 5061.16490779021, 5089.618278629081, 5105.310783044279, 23319.417014574603, 23328.183513576943, 23536.411589710224, 24168.637470437956, 24275.87862060696, 2303.8156947444163, 2353.1528649686097, 2423.3214699883883, 2506.1854897158496, 2660.5743081107125, 14516.491922782652, 15038.248087595577, 15055.623609409742, 15260.084394936339, 15386.384544618202, 1847.1410793980863, 1888.8583356248337, 1894.0908363985227, 1898.9525261868425, 1899.3162461513843, 65127.348726513075, 80898.0, 81077.59461202656, 82524.0, 88984.55507722485, 10903.0, 11063.506426632302, 11070.501827417786, 11245.269057511236, 11247.775044499063, 15696.843031569766, 15763.290651920692, 15792.526224213292, 15830.841691583168, 15865.286062127232, 9029.954850225839, 9087.727368178965, 9256.166944974984, 9266.397684150643, 9297.488638124833, 9086.681966131153, 9151.496667683208, 9160.129787670161, 9207.17135457812, 9282.675106371245, 6825.0, 6983.2318444971015, 7054.717811287491, 7131.750388736473, 7136.286371362822, 1956.461972957448, 1995.162031946586, 2020.3332900143212, 2042.8876411797494, 2045.6522391193234, 1029.2897900448665, 1080.7892460970193, 1083.3499900060058, 1104.5857803323754, 1159.907207423404, 20078.0, 20207.292744753864, 20407.0, 20780.688289675665, 21052.368428947157, 1085.8479812826054, 1114.3369695031442, 1127.4419162514607, 1161.4657257661402, 1161.8257261410688, 11295.604653837076, 11545.942270288595, 11585.76828463426, 11767.117466189899, 11789.3515856627, 493377.0, 495590.0, 507610.0, 511721.0, 514599.0, 87909.56045219733, 89189.0, 89737.0, 90167.0, 91586.54206728924, 1042.124615323117, 1098.6045023791428, 1102.7573933734566, 1103.426218366461, 1103.9172062095374, 18589.628207436046, 18725.595580331257, 18762.624747505248, 18900.716489252398, 18989.05054747285, 43622.127557449305, 43836.0, 44043.33934990913, 45588.31617525806, 46027.30959035684, 63924.68037659782, 64196.67901660649, 64244.357556423834, 64885.67557162184, 66165.66917165383, 7428.517146385468, 7821.843563128819, 8772.649094036167, 8792.120787921156, 9003.459792412476, 9926.362150245417, 13744.175349479063, 14026.719465610835, 14059.718805624036, 14082.929585352007, 11672.88327116718, 12099.57651482194, 12223.388830558259, 12375.443105060114, 12537.561185358469, 11934.940325298317, 12060.336681482602, 12249.0, 12329.876701232874, 12442.0, 12217.755644886875, 12362.196457230251, 12450.315232662291, 12454.065945053975, 12458.31479268649, 8846.0, 8942.284617230736, 9029.593668284811, 9202.0, 9202.217811486098, 9154.542272886461, 11821.940890295493, 11973.0, 11993.40032998364, 12110.878891211327], "value": 9728.063387314565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.4461321617605, 1551.666391725779, 1694.1698567701822, 1835.5686413692772, 1856.9693819929942, 8653.091425400336, 9169.128932751386, 9218.492982885939, 9775.462349570771, 9797.608095676173, 9319.813603727922, 9608.0, 9709.320347575673, 9725.562349694263, 9752.12230899219, 2495.937601559962, 2525.785308248801, 2532.0757923357933, 2532.4428625702317, 2534.6831646044243, 2486.365976675945, 2541.682289713786, 2542.7330130336327, 2543.0082267915527, 2543.36415896026, 2434.196715084018, 2468.3088735154097, 2544.3384719972846, 2546.7580579844885, 2547.0575886921774, 2307.746147923727, 2310.2260742651233, 2343.086196383412, 2344.882755862217, 2347.495288512969, 2432.3311089450367, 2444.828861979662, 2457.680501534789, 2477.0587176872855, 2483.1557270528106, 9624.51877406127, 9639.662611808553, 9727.027297270217, 9745.12293893553, 9776.413415195111, 5625.240592519998, 5718.771249150029, 5753.6260143090985, 5754.367019627837, 5768.0, 3373.1061268763797, 3420.3672320620763, 3508.3158784037123, 3515.3320869035056, 3537.593176784677, 1113.6492005018392, 1129.5481807277072, 1156.670348950545, 1159.3565571108031, 1161.396074041502, 13565.796513052312, 13575.932120339336, 13595.52415665447, 13635.250061246628, 13645.181289122684, 4945.752712364368, 4998.450170481244, 5045.369328833895, 5088.0, 5148.613853960968, 11297.265677731086, 11360.829587556193, 11401.372924489233, 11413.48639311233, 11437.542498300141, 5689.687067211343, 5795.710214489259, 5827.76688932438, 5828.912566311508, 5829.88340233193, 4695.906081878412, 5141.357330333708, 5232.843014709565, 5265.210218467184, 5322.973385133049, 4387.254166791653, 4399.868003959887, 4457.576530229623, 4477.238869392211, 4558.0428110097255, 1296.494367196794, 1317.157019507516, 1318.7428451451874, 1328.8538260791306, 1345.172718777964, 876.6449587916904, 996.880374355082, 1024.8513965474965, 1064.8668916385452, 1069.9304545204536, 6279.434850863444, 6334.841628959313, 6384.7126879290545, 6398.584092034003, 6411.871762564722, 472.1383475157851, 477.164961317694, 479.4773696670646, 489.8310083021352, 489.9020195960822, 4386.912261754747, 4396.670249731283, 4440.977795111068, 4442.089371678798, 4478.798454069574, 11649.825252621218, 12042.698932526757, 12135.0, 12146.028317734561, 12154.635360939186, 11759.823602645967, 11764.823527647091, 11862.22895511789, 11880.108991825648, 11884.227525210834, 8651.653933842575, 8714.172153645393, 8887.244584210286, 8953.462792232487, 9153.405028673249, 6618.1065556151225, 6853.211880633791, 6875.106236189464, 6901.413379862567, 6933.341332573397, 10951.288166269167, 11090.944545277222, 11106.333619982826, 11175.441227938732, 11218.158638102012, 11294.491747871201, 11347.773044538897, 11424.0, 11481.253718508271, 11499.655010349703, 8411.032731235986, 8416.4950102994, 8671.04618491978, 8680.0, 8716.084811094745, 9398.154166125081, 9484.478353690338, 9486.288528360263, 9526.523673816142, 9530.285228607743, 8207.71273005442, 8469.61886715087, 8501.93725784277, 8532.488050716976, 8713.215810577078, 8083.191680832105, 8127.431079824592, 8547.188017138362, 8552.358573106918, 8631.91368086311, 7737.767866964, 7852.725154619561, 7872.330851877655, 7873.0, 7876.803079923047, 5297.073012222922, 5378.784848606012, 5405.378381486179, 5471.808486703106, 5559.694216818114, 5472.26124473207, 5497.532709719719, 5563.5271001963665, 5603.467670571289, 5728.54171666274], "value": 4928.318716463812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.19520723902446, 346.33849347745803, 353.98230088495586, 363.73992595294374, 366.081136347767, 5673.723412232246, 5762.481376676098, 5801.564882633804, 5866.3547009828935, 5877.5297976161855, 5671.291088613923, 5675.943240567593, 5689.146628005801, 5740.0, 5754.568407369454, 4469.374287599739, 4479.283314669654, 4497.955020449803, 4523.525029871849, 4543.522930092342, 4458.331250312447, 4499.797509112082, 4551.7724113794175, 4553.749543775091, 4557.680962332638, 4415.448068991376, 4420.624246938998, 4440.0, 4440.955590444087, 4496.4829044659955, 4460.531644177363, 4483.775811209426, 4487.730736155809, 4487.8429254976245, 4502.7973741181395, 3973.264945985002, 3977.76133431995, 3989.900252493682, 3992.2215168042244, 4044.878653640366, 5493.983613031562, 5606.439356064402, 5619.0895095667665, 5635.351934527541, 5672.234248376458, 5154.175331946908, 5224.791008359661, 5226.137687281594, 5232.2413250078525, 5241.056609810233, 5900.232969713909, 6106.114613381079, 6109.969450152721, 6140.478059364959, 6176.845578860564, 4388.078503514266, 4414.492333381638, 4420.292753159479, 4436.4676238851225, 4437.2013037653205, 6235.189425374672, 6352.841178970517, 6367.522435817286, 6386.2336519617475, 6450.935490645127, 4411.669124815651, 4485.775711214426, 4520.638348932078, 4532.484471118561, 4547.090581883636, 4584.3352713856975, 4595.954040459553, 4598.908021839611, 4607.6313894889, 4615.630749540029, 5196.168613021974, 5217.713025783618, 5225.503577160163, 5233.528982391603, 5265.183896496049, 5919.704014799329, 5929.487980564928, 6065.8180254592435, 6090.634561926298, 6124.5100391968535, 1509.3660662521768, 1534.5038587377442, 1543.8224604170439, 1550.7671401236043, 1555.2068445092857, 960.4141473701037, 964.8890377606665, 978.4618459847055, 985.8521221816785, 994.4878387630376, 5162.0, 5330.6278705975465, 5354.54486368663, 5371.194320851825, 5383.788647554269, 5493.478119578714, 5602.551795856321, 5623.0, 5677.63095398806, 5679.346875109332, 5356.464353564613, 5379.811706590251, 5566.749496272597, 5985.713071689607, 6002.919474494633, 3282.83585820708, 3320.900372988814, 3345.2974875275977, 3358.7648864579733, 3371.2077661749468, 6267.435930766253, 6431.935680643227, 6524.902126468107, 6542.476601871839, 6591.703373348211, 6382.8723425531225, 6411.743530258737, 6442.840288748071, 6450.548461607643, 6454.419102280724, 6290.433860952445, 6426.807195784134, 6432.871342573122, 6485.956923569061, 6565.409113179837, 6220.253569571681, 6231.3145553988115, 6275.6862156892885, 6310.242770867525, 6338.461230795434, 6178.382161783966, 6194.163787888758, 6200.472959798468, 6200.945839207256, 6239.5008399327035, 6295.307516173126, 6523.64119973406, 6534.268418869098, 6539.836504087436, 6541.967290163519, 4526.411566496335, 4554.772261386851, 4574.336721175345, 4583.449986001701, 4590.924080865761, 6080.939190608037, 6273.807976484453, 6288.591241569284, 6303.590266632654, 6351.587146835441, 6084.0, 6113.174721412553, 6118.9291873922775, 6150.846228844136, 6200.379962003944, 6032.75868965254, 6045.486133678511, 6096.298925623432, 6152.107944347955, 6159.168512250789, 5996.850078748066, 6010.549208809444, 6018.0, 6035.577509574287, 6051.576389652682, 6144.218176728878, 6169.691515424301, 6180.907286390618, 6187.690615469119, 6192.59748116371, 5887.293524776883, 6036.3058248302, 6103.11504831788, 6104.633721976696, 6120.877582448237], "value": 4621.874884124332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.4870718728922, 759.525296689569, 884.5665623844317, 916.9083091690827, 918.0635751533435, 15140.167290799016, 16126.354945802183, 16245.756313655305, 16337.183140842955, 16398.590035249126, 16288.348466061372, 16453.0, 16486.25811838467, 16496.917515412435, 16598.336066557353, 713.4898547538509, 827.7847759582522, 855.3328403845011, 857.1043259793531, 859.4800145911727, 855.5593869157389, 862.4092496639822, 864.3387808326635, 865.3207232322628, 865.8960924689046, 918.9494577798218, 923.0400383601046, 925.0148591749798, 925.1534845616253, 928.2388441477991, 908.9772755681095, 912.3066469483207, 914.2822884036033, 914.5335878701877, 915.9358844880861, 673.2863165045068, 675.5710124071201, 676.7462201674372, 679.5175425447937, 680.7141000779684, 15926.442574509952, 15953.0, 16000.359985600679, 16119.758203626954, 16128.112953787655, 13960.371783269675, 14372.281385930766, 14537.636559086002, 15068.54794356171, 15215.0, 13898.444062237499, 14332.06841555306, 14417.71164576713, 14550.272486375745, 14652.780208296885, 4825.0, 4845.152098382804, 4853.587445067174, 4867.3915760529935, 5033.320501732256, 81138.59430702867, 83134.58432707858, 83176.0, 83429.16570834274, 83621.58189209076, 12065.577704780291, 12094.637160885188, 12307.815382769266, 12318.50725970969, 12404.875951240372, 19254.422367329003, 19313.324033658755, 19321.130549125322, 19327.710084348746, 19327.710084348746, 7805.960970195226, 7811.296983271533, 7869.803254918673, 7977.321927636216, 8365.623546940402, 4664.067186562701, 4693.78877950493, 4720.386349774576, 5108.233764935215, 5208.088584497697, 3733.0, 3931.5478719947, 3956.3867600521967, 3959.3269144245546, 3963.980180099081, 674.5312008154384, 687.6424259385192, 689.5552368722147, 690.9550879192836, 691.8201267670441, 763.2596381509926, 764.2586690909809, 815.135955886762, 823.1028179284608, 848.2747251100344, 10739.301945373525, 10917.945410272898, 11131.944340278247, 11180.273282236629, 11275.590551181102, 728.65024788102, 729.5185177782638, 783.2285199078902, 805.8871757953891, 824.3981893217984, 4718.079974405026, 4825.420949486084, 4842.7336496493035, 5059.645824792303, 5077.949220507821, 74526.62736686281, 74791.62604187054, 76993.0, 77652.61173694208, 77930.0, 79860.0, 106551.46724266329, 107485.46257268664, 108564.4571777136, 109915.45042274738, 91092.0, 91961.5401922986, 92194.0, 92816.0, 93584.0, 9714.077162669535, 9800.558974846292, 9850.0, 9857.901420985698, 9875.555599997873, 45178.0, 47499.52500475089, 49455.0, 54398.45601543934, 55215.0, 76866.0, 77493.61253193923, 79518.6024069876, 81725.59137204276, 82013.17986820056, 13723.382447790073, 13833.0, 13880.305984700926, 14075.718485630436, 14146.080504767157, 14762.63093422673, 15501.612459688598, 15639.765403518728, 15778.68442631164, 15856.365745370056, 13399.598012059654, 13798.862011379757, 14122.576322710334, 14151.504697335955, 14188.574342769733, 14180.0, 14590.270486475421, 14974.101553906801, 14979.101253924799, 15100.39598416051, 14161.079529830527, 14364.928175359057, 14702.852971470149, 14816.62958426048, 15624.531264062096, 12001.459934303151, 12479.31363775001, 12523.93738031304, 12559.748805024032, 12980.610581682564, 11848.052155827341, 12061.15571909993, 12136.696582585153, 12173.69565760863, 12241.143119981873], "value": 7974.132944808362, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 109.0, 111.0, 113.0, 110.0, 110.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 156.0, 175.0, 125.0, 149.0, 156.0, 134.0, 176.0, 130.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 165.0, 161.0, 171.0, 162.0, 166.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 167.0, 75.0, 75.0, 74.0, 75.0, 168.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 149.0, 85.0, 85.0, 85.0, 140.0, 84.0, 85.0, 152.0], "value": 103.5, "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, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 105.0, 95.0, 103.0, 101.0, 98.0, 101.0, 95.0, 96.0], "value": 98.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 58.0, 54.0, 52.0, 55.0, 52.0, 52.0, 52.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 84.0, 76.0, 77.0, 83.0, 84.0, 78.0, 115.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 118.0, 126.0, 118.0, 120.0, 116.0, 118.0, 133.0, 142.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 169.0, 158.0, 157.0, 153.0, 157.0, 154.0, 156.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 68.0, 61.0, 65.0, 61.0, 62.0, 60.0], "value": 63.4, "unit": "score"}]}]} 03:45:30 INFO - Return code: 0 03:45:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:30 ERROR - # TBPL SUCCESS # 03:45:30 INFO - Running post-action listener: _resource_record_post_action 03:45:30 INFO - ##### 03:45:30 INFO - ##### Finished run-tests step (success) 03:45:30 INFO - ##### 03:45:30 INFO - Running post-run listener: _resource_record_post_run 03:45:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517181440; Read time: 4; Write time: 390476 03:45:30 INFO - TinderboxPrint: CPU usage
13.4% 03:45:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 03:45:30 INFO - TinderboxPrint: I/O write bytes / time
517,181,440 / 390,476 03:45:30 INFO - TinderboxPrint: CPU idle
8,216.3 (86.6%) 03:45:30 INFO - TinderboxPrint: CPU user
1,212.7 (12.8%) 03:45:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 265510912; Read time: 0; Write time: 244912 03:45:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251670528; Read time: 4; Write time: 145564 03:45:30 INFO - Running post-run listener: _upload_blobber_files 03:45:30 INFO - Blob upload gear active. 03:45:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:30 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 03:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:31 INFO - (blobuploader) - INFO - Done attempting. 03:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:35 INFO - (blobuploader) - INFO - Done attempting. 03:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:36 INFO - (blobuploader) - INFO - Done attempting. 03:45:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:36 INFO - Return code: 0 03:45:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea66299793cfdd071000a140721cb36b15e0d9c1be49dff40738ddc480125992475242b795b63b80c1e7566ef9fe9120a10f6c06c68da2b3ab07f7e8fe298a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6f32a11f52205ca601fa4108388d123389f447296afdbdc930831ef3d2cdef85faa7b215e7cd8694ba057ce7d091088de80e9278e982feb368920317c022863", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6b37c3db8506d9ce21cfbe5a37a130e77ac8cc040085441da2f195895dc4ab3f4243f9d5c42ba2fad39e9a19a42206198f83935fa0fe44eb1bacb1d37532ccf"} 03:45:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:36 INFO - Contents: 03:45:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea66299793cfdd071000a140721cb36b15e0d9c1be49dff40738ddc480125992475242b795b63b80c1e7566ef9fe9120a10f6c06c68da2b3ab07f7e8fe298a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6f32a11f52205ca601fa4108388d123389f447296afdbdc930831ef3d2cdef85faa7b215e7cd8694ba057ce7d091088de80e9278e982feb368920317c022863", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6b37c3db8506d9ce21cfbe5a37a130e77ac8cc040085441da2f195895dc4ab3f4243f9d5c42ba2fad39e9a19a42206198f83935fa0fe44eb1bacb1d37532ccf"} 03:45:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:36 INFO - Copying logs to upload dir... 03:45:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.631876 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-24 03:45:36.234541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:45:36.237727) ========= 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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea66299793cfdd071000a140721cb36b15e0d9c1be49dff40738ddc480125992475242b795b63b80c1e7566ef9fe9120a10f6c06c68da2b3ab07f7e8fe298a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6f32a11f52205ca601fa4108388d123389f447296afdbdc930831ef3d2cdef85faa7b215e7cd8694ba057ce7d091088de80e9278e982feb368920317c022863", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6b37c3db8506d9ce21cfbe5a37a130e77ac8cc040085441da2f195895dc4ab3f4243f9d5c42ba2fad39e9a19a42206198f83935fa0fe44eb1bacb1d37532ccf"} build_url:https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/T9qeA09YQ6WPvxEoyTNYbw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea66299793cfdd071000a140721cb36b15e0d9c1be49dff40738ddc480125992475242b795b63b80c1e7566ef9fe9120a10f6c06c68da2b3ab07f7e8fe298a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6f32a11f52205ca601fa4108388d123389f447296afdbdc930831ef3d2cdef85faa7b215e7cd8694ba057ce7d091088de80e9278e982feb368920317c022863", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6b37c3db8506d9ce21cfbe5a37a130e77ac8cc040085441da2f195895dc4ab3f4243f9d5c42ba2fad39e9a19a42206198f83935fa0fe44eb1bacb1d37532ccf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:45:36.263506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:45:36.263838) ========= 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=41a7e32711b8e08598a63237000001d6-1466758785.225001-1233213033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:45:36.347289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:45:36.347607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:45:36.347893) ========= ========= Total master_lag: 0.18 =========