builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1468491385.68 results: success (0) buildid: 20160714004054 builduid: 6a8ca11f4a37440eb3d20ce92e3d6eb6 revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:25.681138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:25.681618) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:25.681906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:25.693226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:25.693513) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 03:16:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.1M=0s 2016-07-14 03:16:26 (60.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.299926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.005381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.005706) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.055120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.055490) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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 709652b674013b136627e45fd90b4e9063906a19 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 03:16:26,643 truncating revision to first 12 chars 2016-07-14 03:16:26,643 Setting DEBUG logging. 2016-07-14 03:16:26,643 attempt 1/10 2016-07-14 03:16:26,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 03:16:26,940 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.714917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.715274) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.715696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.715975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:26.725296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 22 secs) (at 2016-07-14 03:16:26.725611) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:27 INFO - MultiFileLogger online at 20160714 03:16:27 in /builds/slave/test 03:16:27 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:16:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:27 INFO - {'append_to_log': False, 03:16:27 INFO - 'base_work_dir': '/builds/slave/test', 03:16:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:27 INFO - 'branch': 'Mozilla-Aurora', 03:16:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:27 INFO - 'config_files': ('talos/linux_config.py',), 03:16:27 INFO - 'default_actions': ('clobber', 03:16:27 INFO - 'read-buildbot-config', 03:16:27 INFO - 'download-and-extract', 03:16:27 INFO - 'populate-webroot', 03:16:27 INFO - 'create-virtualenv', 03:16:27 INFO - 'install', 03:16:27 INFO - 'run-tests'), 03:16:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:27 INFO - 'download_minidump_stackwalk': True, 03:16:27 INFO - 'download_symbols': 'ondemand', 03:16:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:27 INFO - 'installer_path': 'installer.exe', 03:16:27 INFO - 'log_level': 'info', 03:16:27 INFO - 'log_name': 'talos', 03:16:27 INFO - 'log_to_console': True, 03:16:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:27 INFO - 'opt_config_files': (), 03:16:27 INFO - 'pip_index': False, 03:16:27 INFO - 'sps_profile': False, 03:16:27 INFO - 'sps_profile_interval': 0, 03:16:27 INFO - 'suite': 'dromaeojs-e10s', 03:16:27 INFO - 'system_bits': '32', 03:16:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:27 INFO - 'title': 'talos-linux64-ix-069', 03:16:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:27 INFO - 'use_talos_json': True, 03:16:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:27 INFO - 'work_dir': 'build'} 03:16:27 INFO - ##### 03:16:27 INFO - ##### Running clobber step. 03:16:27 INFO - ##### 03:16:27 INFO - Running pre-action listener: _resource_record_pre_action 03:16:27 INFO - Running main action method: clobber 03:16:27 INFO - rmtree: /builds/slave/test/build 03:16:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:28 INFO - Running post-action listener: _resource_record_post_action 03:16:28 INFO - ##### 03:16:28 INFO - ##### Finished clobber step (success) 03:16:28 INFO - ##### 03:16:28 INFO - ##### 03:16:28 INFO - ##### Running read-buildbot-config step. 03:16:28 INFO - ##### 03:16:28 INFO - Running pre-action listener: _resource_record_pre_action 03:16:28 INFO - Running main action method: read_buildbot_config 03:16:28 INFO - Using buildbot properties: 03:16:28 INFO - { 03:16:28 INFO - "project": "", 03:16:28 INFO - "product": "firefox", 03:16:28 INFO - "script_repo_revision": "production", 03:16:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:16:28 INFO - "repository": "", 03:16:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:16:28 INFO - "buildid": "20160714004054", 03:16:28 INFO - "stage_platform": "linux64-pgo", 03:16:28 INFO - "basedir": "/builds/slave/test", 03:16:28 INFO - "nightly_build": "True", 03:16:28 INFO - "buildnumber": 397, 03:16:28 INFO - "slavename": "talos-linux64-ix-069", 03:16:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:28 INFO - "platform": "ubuntu64_hw", 03:16:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:28 INFO - "branch": "mozilla-aurora", 03:16:28 INFO - "repo_path": "releases/mozilla-aurora", 03:16:28 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 03:16:28 INFO - "pgo_build": "True", 03:16:28 INFO - "builduid": "6a8ca11f4a37440eb3d20ce92e3d6eb6", 03:16:28 INFO - "slavebuilddir": "test" 03:16:28 INFO - } 03:16:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:16:28 INFO - Running post-action listener: _resource_record_post_action 03:16:28 INFO - ##### 03:16:28 INFO - ##### Finished read-buildbot-config step (success) 03:16:28 INFO - ##### 03:16:28 INFO - ##### 03:16:28 INFO - ##### Running download-and-extract step. 03:16:28 INFO - ##### 03:16:28 INFO - Running pre-action listener: _resource_record_pre_action 03:16:28 INFO - Running main action method: download_and_extract 03:16:28 INFO - mkdir: /builds/slave/test/build/tests 03:16:28 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:16:28 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:29 INFO - Downloaded 1361 bytes. 03:16:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:29 INFO - Using the following test package requirements: 03:16:29 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:29 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:29 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:16:29 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'jsshell-linux-x86_64.zip'], 03:16:29 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:29 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:29 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:29 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:29 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:29 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:29 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:29 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:30 INFO - Downloaded 24490960 bytes. 03:16:30 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:16:30 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:16:31 INFO - Return code: 0 03:16:31 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:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:31 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:33 INFO - Downloaded 24490960 bytes. 03:16:33 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:16:33 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:16:34 INFO - Return code: 0 03:16:34 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:16:34 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:35 INFO - Downloaded 10833369 bytes. 03:16:35 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:16:35 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:16:35 INFO - Return code: 0 03:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:35 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/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:16:37 INFO - Downloaded 63594329 bytes. 03:16:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:37 INFO - mkdir: /builds/slave/test/properties 03:16:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:37 INFO - Contents: 03:16:37 INFO - build_url:https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:38 INFO - Running post-action listener: _resource_record_post_action 03:16:38 INFO - Running post-action listener: set_extra_try_arguments 03:16:38 INFO - ##### 03:16:38 INFO - ##### Finished download-and-extract step (success) 03:16:38 INFO - ##### 03:16:38 INFO - ##### 03:16:38 INFO - ##### Running populate-webroot step. 03:16:38 INFO - ##### 03:16:38 INFO - Running pre-action listener: _resource_record_pre_action 03:16:38 INFO - Running main action method: populate_webroot 03:16:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:38 INFO - '--tppagecycles', 03:16:38 INFO - '7'], 03:16:38 INFO - 'tests': ['tsvgm']}}, 03:16:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['damp', 'tps']}, 03:16:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['damp', 'tps']}, 03:16:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['dromaeo_dom']}, 03:16:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['a11yr', 03:16:38 INFO - 'ts_paint', 03:16:38 INFO - 'tpaint', 03:16:38 INFO - 'sessionrestore', 03:16:38 INFO - 'sessionrestore_no_auto_restore', 03:16:38 INFO - 'tabpaint']}, 03:16:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['tsvgx', 03:16:38 INFO - 'tsvgr_opacity', 03:16:38 INFO - 'tart', 03:16:38 INFO - 'tscrollx', 03:16:38 INFO - 'cart']}, 03:16:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:38 INFO - 'tsvgr_opacity', 03:16:38 INFO - 'tart', 03:16:38 INFO - 'tscrollx', 03:16:38 INFO - 'cart']}, 03:16:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--disable-e10s'], 03:16:38 INFO - 'tests': ['tp5o']}, 03:16:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'tests': ['tp5o']}, 03:16:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--disable-e10s', 03:16:38 INFO - '--xperf_path', 03:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:38 INFO - 'tests': ['tp5n']}, 03:16:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:38 INFO - 'talos_options': ['--xperf_path', 03:16:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:38 INFO - 'tests': ['tp5n']}}, 03:16:38 INFO - 'talos.zip': {'path': '', 03:16:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:38 INFO - Running post-action listener: _resource_record_post_action 03:16:38 INFO - ##### 03:16:38 INFO - ##### Finished populate-webroot step (success) 03:16:38 INFO - ##### 03:16:38 INFO - ##### 03:16:38 INFO - ##### Running create-virtualenv step. 03:16:38 INFO - ##### 03:16:38 INFO - Running pre-action listener: _resource_record_pre_action 03:16:38 INFO - Running main action method: create_virtualenv 03:16:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:38 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:16:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:38 INFO - Using real prefix '/usr' 03:16:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:41 INFO - Installing pip.................done. 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:41 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:16:41 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:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:41 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:16:41 INFO - Cleaning up... 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:41 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:16:41 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:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:41 INFO - Downloading/unpacking psutil>=3.1.1 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:43 INFO - Installing collected packages: psutil 03:16:43 INFO - Running setup.py install for psutil 03:16:43 INFO - building 'psutil._psutil_linux' extension 03:16:43 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:16:43 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:16:43 INFO - building 'psutil._psutil_posix' extension 03:16:43 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:16:43 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:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:43 INFO - Successfully installed psutil 03:16:43 INFO - Cleaning up... 03:16:44 INFO - Return code: 0 03:16:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:16:44 INFO - Using env: {'DISPLAY': ':0', 03:16:44 INFO - 'HOME': '/home/cltbld', 03:16:44 INFO - 'LANG': 'en_US.UTF-8', 03:16:44 INFO - 'LANGUAGE': 'en_US:en', 03:16:44 INFO - 'LOGNAME': 'cltbld', 03:16:44 INFO - 'MAIL': '/var/mail/cltbld', 03:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:44 INFO - 'MOZ_NO_REMOTE': '1', 03:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:44 INFO - 'NO_EM_RESTART': '1', 03:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:44 INFO - 'PWD': '/builds/slave/test', 03:16:44 INFO - 'SHELL': '/bin/bash', 03:16:44 INFO - 'SHLVL': '1', 03:16:44 INFO - 'TERM': 'linux', 03:16:44 INFO - 'TMOUT': '86400', 03:16:44 INFO - 'USER': 'cltbld', 03:16:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:44 INFO - '_': '/tools/buildbot/bin/python'} 03:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:16:46 INFO - Installing collected packages: mozsystemmonitor 03:16:46 INFO - Running setup.py install for mozsystemmonitor 03:16:46 INFO - Successfully installed mozsystemmonitor 03:16:46 INFO - Cleaning up... 03:16:46 INFO - Return code: 0 03:16:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:16:46 INFO - Using env: {'DISPLAY': ':0', 03:16:46 INFO - 'HOME': '/home/cltbld', 03:16:46 INFO - 'LANG': 'en_US.UTF-8', 03:16:46 INFO - 'LANGUAGE': 'en_US:en', 03:16:46 INFO - 'LOGNAME': 'cltbld', 03:16:46 INFO - 'MAIL': '/var/mail/cltbld', 03:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:46 INFO - 'MOZ_NO_REMOTE': '1', 03:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:46 INFO - 'NO_EM_RESTART': '1', 03:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:46 INFO - 'PWD': '/builds/slave/test', 03:16:46 INFO - 'SHELL': '/bin/bash', 03:16:46 INFO - 'SHLVL': '1', 03:16:46 INFO - 'TERM': 'linux', 03:16:46 INFO - 'TMOUT': '86400', 03:16:46 INFO - 'USER': 'cltbld', 03:16:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:46 INFO - '_': '/tools/buildbot/bin/python'} 03:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:48 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:16:48 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:16:48 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:16:48 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:16:48 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:16:48 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:16:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:48 INFO - warning: no files found matching '*.txt' 03:16:48 INFO - no previously-included directories found matching 'build' 03:16:48 INFO - no previously-included directories found matching 'dist' 03:16:48 INFO - no previously-included directories found matching '.git*' 03:16:48 INFO - Installing collected packages: jsonschema, functools32 03:16:48 INFO - Running setup.py install for functools32 03:16:48 INFO - warning: no files found matching '*.txt' 03:16:48 INFO - no previously-included directories found matching 'build' 03:16:48 INFO - no previously-included directories found matching 'dist' 03:16:48 INFO - no previously-included directories found matching '.git*' 03:16:48 INFO - Successfully installed jsonschema functools32 03:16:48 INFO - Cleaning up... 03:16:48 INFO - Return code: 0 03:16:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:48 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:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 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:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:48 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:16:48 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:16:48 INFO - Using env: {'DISPLAY': ':0', 03:16:48 INFO - 'HOME': '/home/cltbld', 03:16:48 INFO - 'LANG': 'en_US.UTF-8', 03:16:48 INFO - 'LANGUAGE': 'en_US:en', 03:16:48 INFO - 'LOGNAME': 'cltbld', 03:16:48 INFO - 'MAIL': '/var/mail/cltbld', 03:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:48 INFO - 'MOZ_NO_REMOTE': '1', 03:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:48 INFO - 'NO_EM_RESTART': '1', 03:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:48 INFO - 'PWD': '/builds/slave/test', 03:16:48 INFO - 'SHELL': '/bin/bash', 03:16:48 INFO - 'SHLVL': '1', 03:16:48 INFO - 'TERM': 'linux', 03:16:48 INFO - 'TMOUT': '86400', 03:16:48 INFO - 'USER': 'cltbld', 03:16:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:48 INFO - '_': '/tools/buildbot/bin/python'} 03:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - Downloading docopt-0.6.1.tar.gz 03:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:51 INFO - Running setup.py install for blobuploader 03:16:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:51 INFO - Running setup.py install for requests 03:16:52 INFO - Running setup.py install for docopt 03:16:52 INFO - Successfully installed blobuploader requests docopt 03:16:52 INFO - Cleaning up... 03:16:52 INFO - Return code: 0 03:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:52 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:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 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:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:52 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:16:52 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:16:52 INFO - Using env: {'DISPLAY': ':0', 03:16:52 INFO - 'HOME': '/home/cltbld', 03:16:52 INFO - 'LANG': 'en_US.UTF-8', 03:16:52 INFO - 'LANGUAGE': 'en_US:en', 03:16:52 INFO - 'LOGNAME': 'cltbld', 03:16:52 INFO - 'MAIL': '/var/mail/cltbld', 03:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:52 INFO - 'MOZ_NO_REMOTE': '1', 03:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:52 INFO - 'NO_EM_RESTART': '1', 03:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:52 INFO - 'PWD': '/builds/slave/test', 03:16:52 INFO - 'SHELL': '/bin/bash', 03:16:52 INFO - 'SHLVL': '1', 03:16:52 INFO - 'TERM': 'linux', 03:16:52 INFO - 'TMOUT': '86400', 03:16:52 INFO - 'USER': 'cltbld', 03:16:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:52 INFO - '_': '/tools/buildbot/bin/python'} 03:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:52 INFO - Running setup.py (path:/tmp/pip-E4CiEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:52 INFO - Running setup.py (path:/tmp/pip-ddfSmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:52 INFO - Running setup.py (path:/tmp/pip-2XRDkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:52 INFO - Running setup.py (path:/tmp/pip-ka9nNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:52 INFO - Running setup.py (path:/tmp/pip-nkmHyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:53 INFO - Running setup.py (path:/tmp/pip-6UaX7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:53 INFO - Running setup.py (path:/tmp/pip-Hu2iPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:53 INFO - Running setup.py (path:/tmp/pip-uIyfYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:53 INFO - Running setup.py (path:/tmp/pip-GHq9Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:53 INFO - Running setup.py (path:/tmp/pip-hV5dNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:53 INFO - Running setup.py (path:/tmp/pip-H6RIna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:53 INFO - Running setup.py (path:/tmp/pip-ZMkzEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:53 INFO - Running setup.py (path:/tmp/pip-cLvEAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:53 INFO - Running setup.py (path:/tmp/pip-N82hid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:53 INFO - Running setup.py (path:/tmp/pip-UnAMqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:53 INFO - Running setup.py (path:/tmp/pip-DCK5ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:53 INFO - Running setup.py (path:/tmp/pip-FGgtRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:53 INFO - Running setup.py install for manifestparser 03:16:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for mozcrash 03:16:54 INFO - Running setup.py install for mozdebug 03:16:54 INFO - Running setup.py install for mozdevice 03:16:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for mozfile 03:16:54 INFO - Running setup.py install for mozhttpd 03:16:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for mozinfo 03:16:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for mozInstall 03:16:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for mozleak 03:16:54 INFO - Running setup.py install for mozlog 03:16:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:54 INFO - Running setup.py install for moznetwork 03:16:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Running setup.py install for mozprocess 03:16:55 INFO - Running setup.py install for mozprofile 03:16:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Running setup.py install for mozrunner 03:16:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Running setup.py install for mozscreenshot 03:16:55 INFO - Running setup.py install for moztest 03:16:55 INFO - Running setup.py install for mozversion 03:16:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:55 INFO - Cleaning up... 03:16:55 INFO - Return code: 0 03:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:55 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:55 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:16:55 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:16:55 INFO - Using env: {'DISPLAY': ':0', 03:16:55 INFO - 'HOME': '/home/cltbld', 03:16:55 INFO - 'LANG': 'en_US.UTF-8', 03:16:55 INFO - 'LANGUAGE': 'en_US:en', 03:16:55 INFO - 'LOGNAME': 'cltbld', 03:16:55 INFO - 'MAIL': '/var/mail/cltbld', 03:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:55 INFO - 'MOZ_NO_REMOTE': '1', 03:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:55 INFO - 'NO_EM_RESTART': '1', 03:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:55 INFO - 'PWD': '/builds/slave/test', 03:16:55 INFO - 'SHELL': '/bin/bash', 03:16:55 INFO - 'SHLVL': '1', 03:16:55 INFO - 'TERM': 'linux', 03:16:55 INFO - 'TMOUT': '86400', 03:16:55 INFO - 'USER': 'cltbld', 03:16:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:55 INFO - '_': '/tools/buildbot/bin/python'} 03:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:55 INFO - Running setup.py (path:/tmp/pip-xDhAA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:55 INFO - Running setup.py (path:/tmp/pip-e7ZFT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:56 INFO - Running setup.py (path:/tmp/pip-RBddK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:56 INFO - Running setup.py (path:/tmp/pip-Sjf428-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:56 INFO - Running setup.py (path:/tmp/pip-xaupWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:56 INFO - Running setup.py (path:/tmp/pip-ONIphm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:56 INFO - Running setup.py (path:/tmp/pip-2jmiF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:56 INFO - Running setup.py (path:/tmp/pip-DA_0Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:56 INFO - Running setup.py (path:/tmp/pip-wfE3no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:56 INFO - Running setup.py (path:/tmp/pip-QIAbPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:56 INFO - Running setup.py (path:/tmp/pip-IGEciI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:56 INFO - Running setup.py (path:/tmp/pip-aTLova-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:56 INFO - Running setup.py (path:/tmp/pip-u1PH3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:56 INFO - Running setup.py (path:/tmp/pip-musNu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:56 INFO - Running setup.py (path:/tmp/pip-COfZo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:56 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:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:56 INFO - Running setup.py (path:/tmp/pip-SlxFsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:57 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:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:57 INFO - Running setup.py (path:/tmp/pip-c5SLzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:59 INFO - Downloading blessings-1.6.tar.gz 03:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:59 INFO - Installing collected packages: blessings 03:16:59 INFO - Running setup.py install for blessings 03:16:59 INFO - Successfully installed blessings 03:16:59 INFO - Cleaning up... 03:16:59 INFO - Return code: 0 03:16:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:59 INFO - Reading from file tmpfile_stdout 03:16:59 INFO - Current package versions: 03:16:59 INFO - argparse == 1.2.1 03:16:59 INFO - blessings == 1.6 03:16:59 INFO - blobuploader == 1.2.4 03:16:59 INFO - docopt == 0.6.1 03:16:59 INFO - functools32 == 3.2.3-2 03:16:59 INFO - jsonschema == 2.5.1 03:16:59 INFO - manifestparser == 1.1 03:16:59 INFO - mozInstall == 1.12 03:16:59 INFO - mozcrash == 0.17 03:16:59 INFO - mozdebug == 0.1 03:16:59 INFO - mozdevice == 0.48 03:16:59 INFO - mozfile == 1.2 03:16:59 INFO - mozhttpd == 0.7 03:16:59 INFO - mozinfo == 0.9 03:16:59 INFO - mozleak == 0.1 03:16:59 INFO - mozlog == 3.2 03:16:59 INFO - moznetwork == 0.27 03:16:59 INFO - mozprocess == 0.23 03:16:59 INFO - mozprofile == 0.28 03:16:59 INFO - mozrunner == 6.12 03:16:59 INFO - mozscreenshot == 0.1 03:16:59 INFO - mozsystemmonitor == 0.3 03:16:59 INFO - moztest == 0.7 03:16:59 INFO - mozversion == 1.4 03:16:59 INFO - psutil == 3.1.1 03:16:59 INFO - requests == 1.2.3 03:16:59 INFO - wsgiref == 0.1.2 03:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:59 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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:59 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:16:59 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:16:59 INFO - Using env: {'DISPLAY': ':0', 03:16:59 INFO - 'HOME': '/home/cltbld', 03:16:59 INFO - 'LANG': 'en_US.UTF-8', 03:16:59 INFO - 'LANGUAGE': 'en_US:en', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MAIL': '/var/mail/cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SHLVL': '1', 03:16:59 INFO - 'TERM': 'linux', 03:16:59 INFO - 'TMOUT': '86400', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - '_': '/tools/buildbot/bin/python'} 03:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 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:16:59 INFO - Cleaning up... 03:16:59 INFO - Return code: 0 03:16:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:59 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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:59 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:16:59 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:16:59 INFO - Using env: {'DISPLAY': ':0', 03:16:59 INFO - 'HOME': '/home/cltbld', 03:16:59 INFO - 'LANG': 'en_US.UTF-8', 03:16:59 INFO - 'LANGUAGE': 'en_US:en', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MAIL': '/var/mail/cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SHLVL': '1', 03:16:59 INFO - 'TERM': 'linux', 03:16:59 INFO - 'TMOUT': '86400', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - '_': '/tools/buildbot/bin/python'} 03:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:59 INFO - Cleaning up... 03:16:59 INFO - Return code: 0 03:16:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:16:59 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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 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 0x7f44dcec1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', '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:16:59 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:16:59 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:16:59 INFO - Using env: {'DISPLAY': ':0', 03:16:59 INFO - 'HOME': '/home/cltbld', 03:16:59 INFO - 'LANG': 'en_US.UTF-8', 03:16:59 INFO - 'LANGUAGE': 'en_US:en', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MAIL': '/var/mail/cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SHLVL': '1', 03:16:59 INFO - 'TERM': 'linux', 03:16:59 INFO - 'TMOUT': '86400', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - '_': '/tools/buildbot/bin/python'} 03:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:00 INFO - Downloading/unpacking flake8 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:17:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:17:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:02 INFO - no previously-included directories found matching 'docs/_build' 03:17:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:17:02 INFO - Running setup.py install for pep8 03:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:03 INFO - no previously-included directories found matching 'docs/_build' 03:17:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:17:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:17:03 INFO - Cleaning up... 03:17:03 INFO - Return code: 0 03:17:03 INFO - Running post-action listener: _resource_record_post_action 03:17:03 INFO - Running post-action listener: _start_resource_monitoring 03:17:03 INFO - Starting resource monitoring. 03:17:03 INFO - ##### 03:17:03 INFO - ##### Finished create-virtualenv step (success) 03:17:03 INFO - ##### 03:17:03 INFO - ##### 03:17:03 INFO - ##### Running install step. 03:17:03 INFO - ##### 03:17:03 INFO - Running pre-action listener: _resource_record_pre_action 03:17:03 INFO - Running main action method: install 03:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:03 INFO - Reading from file tmpfile_stdout 03:17:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:03 INFO - Reading from file tmpfile_stdout 03:17:03 INFO - Output received: 03:17:03 INFO - Usage: mozinstall [options] installer 03:17:03 INFO - Options: 03:17:03 INFO - -h, --help show this help message and exit 03:17:03 INFO - -d DEST, --destination=DEST 03:17:03 INFO - Directory to install application into. [default: 03:17:03 INFO - "/builds/slave/test"] 03:17:03 INFO - --app=APP Application being installed. [default: firefox] 03:17:03 INFO - mkdir: /builds/slave/test/build/application 03:17:03 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:17:03 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:17:19 INFO - Reading from file tmpfile_stdout 03:17:19 INFO - Output received: 03:17:19 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:19 INFO - Running post-action listener: _resource_record_post_action 03:17:19 INFO - ##### 03:17:19 INFO - ##### Finished install step (success) 03:17:19 INFO - ##### 03:17:19 INFO - ##### 03:17:19 INFO - ##### Running run-tests step. 03:17:19 INFO - ##### 03:17:19 INFO - Running pre-action listener: _resource_record_pre_action 03:17:19 INFO - Running main action method: run_tests 03:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:19 INFO - Python 2.7.3 03:17:19 INFO - Return code: 0 03:17:19 INFO - grabbing minidump binary from tooltool 03:17: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:17:19 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 0x25792e0>, '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 0x24e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:19 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:17:19 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:17:19 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:17:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:19 INFO - Return code: 0 03:17:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:17:20 INFO - Return code: 0 03:17:20 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/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:17:20 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/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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:17:20 INFO - Using env: {'DISPLAY': ':0', 03:17:20 INFO - 'HOME': '/home/cltbld', 03:17:20 INFO - 'LANG': 'en_US.UTF-8', 03:17:20 INFO - 'LANGUAGE': 'en_US:en', 03:17:20 INFO - 'LOGNAME': 'cltbld', 03:17:20 INFO - 'MAIL': '/var/mail/cltbld', 03:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:20 INFO - 'MOZ_NO_REMOTE': '1', 03:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:20 INFO - 'NO_EM_RESTART': '1', 03:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:20 INFO - 'PWD': '/builds/slave/test', 03:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:20 INFO - 'SHELL': '/bin/bash', 03:17:20 INFO - 'SHLVL': '1', 03:17:20 INFO - 'TERM': 'linux', 03:17:20 INFO - 'TMOUT': '86400', 03:17:20 INFO - 'USER': 'cltbld', 03:17:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570', 03:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:20 INFO - '_': '/tools/buildbot/bin/python'} 03:17:20 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/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:17:20 INFO - mozversion application_buildid: 20160714004054 03:17:20 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 03:17:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:20 INFO - mozversion application_name: Firefox 03:17:20 INFO - mozversion application_remotingname: firefox-dev 03:17:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:20 INFO - mozversion application_vendor: Mozilla 03:17:20 INFO - mozversion application_version: 49.0a2 03:17:20 INFO - mozversion platform_buildid: 20160714004054 03:17:20 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 03:17:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:20 INFO - mozversion platform_version: 49.0a2 03:17:20 INFO - using testdate: 1468491440 03:17:20 INFO - actual date: 1468491440 03:17:20 INFO - starting webserver on 'localhost:56231' 03:17:20 INFO - SUITE-START | Running 2 tests 03:17:20 INFO - TEST-START | dromaeo_css 03:17:20 INFO - operating with platform_type : linux_ 03:17:20 INFO - Initialising browser for dromaeo_css test... 03:17:20 INFO - TEST-INFO | started process 21651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxAVZi/profile http://localhost:56231/getInfo.html) 03:17:25 INFO - PROCESS | 21651 | __metrics Screen width/height:1600/1200 03:17:25 INFO - PROCESS | 21651 | colorDepth:24 03:17:25 INFO - PROCESS | 21651 | Browser inner width/height: 1024/697 03:17:25 INFO - PROCESS | 21651 | __metrics 03:17:26 ERROR - PROCESS | 21651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:17:27 INFO - TEST-INFO | 21651: exit 0 03:17:27 INFO - Browser initialized. 03:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:27 INFO - TEST-INFO | started process 21787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxAVZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:38 INFO - PROCESS | 21787 | RSS: Main: 155865088 03:17:38 INFO - PROCESS | 21787 | 03:18:28 INFO - PROCESS | 21787 | 1468491508477 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:20:36 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56231/tests/dromaeo/cssquery-ext.html) 03:20:37 INFO - PROCESS | 21787 | RSS: Main: 159612928 03:20:37 INFO - PROCESS | 21787 | 03:23:39 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-ext.html (next: http://localhost:56231/tests/dromaeo/cssquery-jquery.html) 03:23:40 INFO - PROCESS | 21787 | RSS: Main: 157782016 03:23:40 INFO - PROCESS | 21787 | 03:26:42 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56231/tests/dromaeo/cssquery-mootools.html) 03:26:42 INFO - PROCESS | 21787 | RSS: Main: 157388800 03:26:42 INFO - PROCESS | 21787 | 03:29:44 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56231/tests/dromaeo/cssquery-prototype.html) 03:29:45 INFO - PROCESS | 21787 | RSS: Main: 156196864 03:29:45 INFO - PROCESS | 21787 | 03:32:47 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56231/tests/dromaeo/cssquery-yui.html) 03:32:48 INFO - PROCESS | 21787 | RSS: Main: 158355456 03:32:48 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | Cycle 1(1): loaded http://localhost:56231/tests/dromaeo/cssquery-yui.html (next: http://localhost:56231/tests/dromaeo/cssquery-dojo.html) 03:35:50 INFO - PROCESS | 21787 | RSS: Main: 158703616 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | __start_tp_report 03:35:50 INFO - PROCESS | 21787 | _x_x_mozilla_page_load 03:35:50 INFO - PROCESS | 21787 | _x_x_mozilla_page_load_details 03:35:50 INFO - PROCESS | 21787 | |i|pagename|runs| 03:35:50 INFO - PROCESS | 21787 | |0;dojo.html;3327.2347360107174;3384.458486642138;3384.543086683297;3393.9999999999986;3407.625161232266;5689.345725241598;5693.772249110036;5710.885782284357;5796.913046304308;5841.766329346821;5796.623219490741;5822.505087067604;5839.474447299742;5845.85385365365;5876.206712093866;5157.174852023686;5200.08998425276;5232.633715639907;5253.369595648527;5279.577633789288;5068.1890897456415;5091.490850914916;5152.974235128819;5239.21411788231;5294.4176140624695;5174.404943431516;5204.635675502716;5212.348456442945;5224.63427560071;5226.608004399666;5229.60777941654;5285.2600635911;5300.655457395257;5306.575473962073;5315.813946511854;5042.319286896259;5157.355330583677;5227.18978558324;5272.762725677354;5278.340207474066;5615.971920140414;5631.521320687746;5644.125160600072;5723.685197314146;5730.971345143289;6226.377362263737;6258.280297765724;6271.122042913996;6282.994720844688;6293.653849038301;6047.244094488189;6183.87632247357;6295.401936815995;6303.653299068549;6336.524760642924;5871.1193321001765;5888.293404791452;5900.468957793819;5905.350411454737;5938.613990090674;6462.644554549545;6468.8059358219325;6486.837829054311;6497.805065848032;6503.349665033459;5799.130130480462;6020.157177995085;6031.939680603138;6204.689765511706;6211.09939058834;6227.1282020517165;6227.377262273827;6231.158793562811;6231.532635052298;6239.282482514569;6166.167567378437;6205.100260462298;6212.968935155386;6230.501559875199;6237.03325984464;5936.1095835625;6095.664738439428;6111.591738512148;6140.2017737694705;6184.226971628546;4714.175019371596;4735.479097299294;4736.715797052119;4755.286706993909;4761.40482439695;4201.264778663783;4229.809658565372;4240.787960601958;4246.745195288293;4259.105587826529;5655.773769049274;5804.593678442468;5824.970875145682;5868.706564671835;5922.763089476372;6119.663418511936;6194.535409844189;6199.442050215412;6204.13142160098;6207.037909124093;5844.1818145459665;5893.027650437715;5908.505090266094;5924.052151655715;5973.880522389528;5194.6104042196985;5321.3348331458565;5347.385050719139;5356.276902618097;5373.140297552372;6310.495160387158;6334.873302533923;6341.048842673636;6343.460805831463;6346.619202847844;6030.6080104793045;6253.187085678833;6253.280872699606;6258.280297765815;6269.937300627118;6185.84535386619;6232.968835155795;6267.874642507216;6380.3619638035825;6392;6213.782517612042;6220.440160385587;6224.190855188977;6227.719752611234;6233.0338797486465;5994.490468310242;6125.754969801158;6325.620462772248;6326.810195694136;6344.048392741126;6005.669688167192;6050.031994880798;6089.969550152221;6090.969545152246;6125.785597504066;6008.339082700987;6053.182820319201;6060.333363329942;6065.2418447694035;6089.725962331617;5688.004599195207;5878.177055212359;5901.940980590139;5922.822315330547;5986.940130598812;6065.090236464565;6107.267127944675;6116.97620400545;6122.969385153046;6155.076738489262;5942.049272116441;5943.613665111754;5945.940540594539;5980.671063091571;6004.189434426296 03:35:50 INFO - PROCESS | 21787 | |1;ext.html;572.5877368294827;605.7037938810945;618.5330075792773;623.6663385088979;659.1793217444283;45738.77130614346;47272;47363.28955065672;49287.50712492874;49706.75146624262;46615.53384466154;46833.76583117079;46997.29504057442;47110.76444617772;47336.289955650696;9051.32115091369;9075.954620226923;9135.588898499584;9144.725658230263;9186.035466276046;9022.233110185642;9055.411398259124;9075.273978081737;9114.270858331318;9145.314101442385;9119.817603647924;9171.816563668723;9195.172434480895;9205.125513076247;9207.585658645343;9083.364164508486;9088.50013249271;9102.044285350075;9149.359544831832;9186;8966.417182883091;8998.59506322217;9021.594028268679;9038;9072.228860546862;43662.47181348669;43928.78035609834;44057.77971110156;44118;44131.338029929255;3361.966380336214;3455.6026057003264;3672.4307732301536;4011.939820902689;4118.279301122292;33783.32433351344;33880;34196.658033419844;34233.48649770256;34246.65753342459;4661.394018777572;4671.135839869635;4681.1105889881155;4750.928736068961;4811.326414302001;334602;336897;337336;338139;339763;36964;37899.24201515954;60352.39647603468;60628.39371606227;60698;39809.00477488086;39852.800735996134;39898.40152397716;39963.40054899179;40057.399139012356;15220.695586088215;15271.847281527265;15301.311440985182;15372.231388430533;15384.307706153026;12624.368781560885;12655.620331390073;12688.746225075447;12702;12718.173318734252;9105;9109.681161159328;9129.08709129095;9183.31125165602;9200;3340.315235376742;3454.7408944329277;3463.1861512544533;3467.687908088284;3518.7185025197923;1071.421432426481;1115.3753897817248;1121.1479275750326;1129.4647752534515;1208.3656080557778;32321.676783231866;32655.530501127505;32991;33133.3373332532;33651.15872103217;1091.901728844392;1127.3067063755896;1139.418896362861;1209.564556759566;1245.6761242076943;16868.24092915822;16895.915520422564;16909.408170713967;16955.915220424067;17169.91415042917;543458;543921;547914;548015;548850;62546.68726656338;62856.37143628505;63308.683456582425;63358;63478.36521634817;1428.2358937968138;1436.6623843396794;1456.7377871983144;1465.772805215172;1471.2570152073135;30616.84691576528;31025.534616981215;31296.374072518876;31606.209844753146;31961.6803831968;52431.73784131055;52453.47546524639;52558.47441525689;52563;52567.211491826885;445787;452342;454925;456275;456669;30201.09396718102;30408.84795576008;30720.385592288476;30893.227669308446;30956.535651964787;51134.48865511446;51147.48852511427;51686.74156629193;52104.47895520996;52513.21230181627;42775;43249.56750432456;43523.56476435195;44263.11473770571;44796.55203447924;42734.35898461588;42762.715494698314;43112.78443607762;43172.56827431686;44406.55593444154;37166.81416593008;42493.787531062146;42749.786251068545;43796.78101609471;44291;38105.61894381021;38214.23571528609;38360.80819595884;38598;39450.80274598609;28876.42247155003;29344.266393339483;29621.703782961893;29810.403791923607;29993.400131997674 03:35:50 INFO - PROCESS | 21787 | |2;jquery.html;423.58911855500173;424.8916526285797;428.0988519167153;432.1184783042593;440.6871121503732;18963.62072758544;19424.805751942476;19939.202431902726;21033.68449473259;21040.684389734168;17111.91444042778;18264.908675456638;19785.703214451794;20535.28126515572;20566.89716551419;5695.77216911323;5861.7948371807;5886.823395298148;5911.201987731666;5917.142014407908;5782.392848750884;5865.706714664271;5870.207521984542;5937.614055086406;5952.494038006775;5802.564807639423;5836.6789826559525;5882.911756323659;5886.440788125121;5893.911591326134;5653.406392328808;5836.737346819404;5852.414758524156;5854.268216472941;5882.499987501024;5263.421023687391;5301.284326615896;5313.282706834605;5325.254464374991;5342.332208473941;22957.885210574008;23749.762502374928;23750.881245593835;23843.642345364835;24311.14910978125;2601.1026195962554;2637.1824734332226;2660.0822716162893;2850.586664933573;2937.221636266391;15114.470993515175;15312.540623781193;15468.381264749396;15505.534833955;15662;2026.5642886779412;2102.9894850525648;2128.9148434062618;2129.1483406637312;2185.4536365908525;75893.62053189754;80133;80405;80638;80739.59630201811;11195.60815371458;11255.43722813856;11387;11429.542818287342;11498.310101393776;16412.75380869288;16475.6704865902;16487.917560412123;16517.091559964316;16543.83456165423;8178.754637360888;8187.549684767395;8195.221453961864;8346.998360196816;8425.325973922072;7673.194314596887;7729.265719756614;7755.883661745078;7805.33654639362;7896.644650990719;7109.253528379549;7118.220444888778;7138.785836424916;7216.819579510554;7220.602866842374;2028.3610662641515;2035.4809523571394;2037.215671966274;2047.2527527452671;2073.139647046489;993.3642468819961;999.3454287441738;1007.0030669637154;1024.6925922223304;1174.9236299640495;17815.287388504574;19358;19836;20074.598508029758;20193.091310891046;1002.8746406699163;1044.5926088825365;1055.2613170780485;1102.4928532874808;1115.3085087245797;10845.728856778485;11350.14873884462;11391;11547.653570392902;11577.247478914012;379958;470030;471429;474989;477783;75325.62337188389;77866.61066694744;80162;80735;80874.59562702266;1063.638362956583;1073.3238060022293;1086.4947799273375;1103.6854496468468;1106.645873320546;17358.91320543389;17603.207855646782;17634.118294084987;17814.554636134202;17943.820561794215;27942.58086128669;39240.6075939237;39450.60549394584;39589.60410395974;39967.400488992105;51828.22257666063;52917.7354113227;53469.7326513365;53513.46486535085;53539.464605353445;9060.456372617664;9083.318751093562;9281.767955801159;9325.487098209664;9499.62001519959;13437.260950647807;13731.931340343235;13792.241426721626;13864.514741983981;14116.647083822987;12139.696507587381;12263.9386803069;12299.200551964093;12395;12563.120581559204;12185.69535761613;12219.816702749644;12303.630891073282;12430.37848107573;12480.625581232578;9641.662541811003;12505.249685018927;12566.37168141571;12662.303573303558;12706.682332941751;8251.83496330082;8548.914510854811;9180.127887850644;9183.678571249975;9311.674091406769;9675.371100878421;12203.328816915155;12223.388830558259;12637.620871373874;12703.618891433272 03:35:50 INFO - PROCESS | 21787 | |3;mootools.html;1569.74884018557;1596.1859451679643;1809.4842969753615;1873.672107381208;1912.5887934094158;8782.824343513126;9463.905360946388;9501.239900807936;10130.341527800698;10196.592136314539;9617.903820961788;9784.266180036508;9914.504274786268;9939.105480506752;10003.349782264148;2531.7215106338335;2553.4127150755244;2569.871506424681;2573.858437785921;2577.8324408913454;2463.59350707134;2546.898124075035;2548.2610043087484;2558.5010922870047;2562.9102981395654;2485.490474452742;2493.7880280176205;2532.708738495069;2533.5312967101145;2535.8858851351642;2404.5431368040104;2437.2810021043833;2448.2288079254977;2452.6811514503;2472.554940110779;2509.912153074634;2517.6727025486753;2525.053105085593;2526.5325914705836;2562.3466016165758;9764.316497845153;9856.90143098567;9902.950485247527;9927.751806204831;9947.10476057151;5793.420657934215;5958.5828991970575;6039.063945088518;6039.5772295939305;6039.698015099228;3628.310620982005;3734.178480734234;3799.126200973764;3802.0874990002476;3809.5238095238096;1232.2668012532529;1239.3865036806749;1253.523661008811;1263.8420197475316;1327.9535216267384;13971.720565588632;13992.440302387893;14010.649733756636;14062.92968535161;14095.22476263805;5158;5205.869853253699;5269.947300527022;5297.152455607084;5349.812756553502;11836.644900652995;11860.76278474443;11887.108466864847;11923.821142682868;11967.341796201119;5939.227900372924;5945.910811337833;5947.167396564484;5966.343702192756;5972.074328479092;4777.808887644455;5130.692158470503;5166.819161329336;5373.596980226421;5380.91928621071;4368.082702632482;4481.820727170877;4542.659300552472;4554.316852472156;4574.245249533857;1345.206328266308;1357.2942070123677;1370.2669072046408;1375.4291968832822;1391.3669280477359;931.5202670624634;997.7256254530063;1004.3120462483222;1016.3749294184172;1021.1779517488493;6251.562390632612;6279.0895320178315;6409.583377080475;6525.608463492111;6598.73605055802;499.60531180367104;502.30932467856695;504.28139900642174;506.6478797235959;514.9330587023663;4257.765822879709;4320.740755554677;4393.538678438782;4412.580804823537;4463.843765468193;11700.35648039366;11993.340366279765;12289.69275768095;12436.626901192978;12472.251664900135;12231.143819932518;12323.198992065667;12324.32216228116;12379.442925068393;12425;8771.780705482413;9019.684311049083;9127.680531181377;9141.680041198526;9415.482148481762;6180.351063138306;6243.157173781663;6344.175257216532;6375.776847810304;6466.612003279818;10521.579136834442;10837.729056773644;10984.670459886216;11387.089032877515;11393.601223957121;11147.665570032912;11204.66386008421;11230;11293.71765705864;11296.49165787525;8363.95818020906;9180.954095229748;9395.577199026196;9463.432194068379;9685.32202745801;9670.371425857296;9727.270454715783;9743.171830394496;9767.658131965347;9771.462569558742;8094.190580942094;8443.83112337762;8516.063233044484;8591.828163436572;8613.655453782028;8336.62485188156;8419.115992820665;8441.240288374076;8487.745367638981;8559.144085591392;7680.884786728092;7714.498557593738;7771.961140194263;7780.533168009937;7783.182765809508;5466.671999680032;5500.7524661391135;5613.943860561342;5702.230198923092;5704.458076482728;5408.78364865401;5477.616566840283;5601.775928962796;5658.462446067617;5664.320281566238 03:35:50 INFO - PROCESS | 21787 | |4;prototype.html;361.59862552566653;364.67908240748136;366.63702934095255;367.5809577082127;370.11727031030983;5781.797637082703;5796.391378905218;5814.69169436877;5834.095715164156;5843.211166492522;5308.203769434577;5667.603267771257;5683.261176047118;5699.914501282484;5707.343655479621;4361.60745532902;4376.234159022174;4390.934135987971;4391.736495810245;4392.604665580097;4416.470023597173;4430.357598148266;4431.980644451778;4440.888977775549;4462.933056004163;4363.978180109095;4433.689641725081;4437.667174961891;4461.1523810476065;4472.038511719979;4324.2648749712625;4349.108432771274;4352.216601011816;4390.538993405694;4408.360787685768;3851.5763266040713;3870.632289932452;3893.7079719020903;3899.53205615328;3910.5502867170353;5423.396769550638;5428.511433970922;5449.782008719647;5450.547253735835;5462.726863656841;4993.975030124862;5058.696478211319;5070.416902056237;5070.847874563769;5086.618503612244;5898.557608179361;5920.141579470996;5964.701764911737;5967.880642387128;5976.880462390772;4261.169072030955;4268.954106243959;4315.676324275661;4336.609705126553;4352.151330490556;5956.880862382728;6055.9697201514155;6134.263888333384;6163.907541386883;6229.906551401733;4367.995361066973;4376.102898905717;4376.6498680105515;4376.715513491613;4389.561043895649;4397.2964325707735;4446.710963787408;4455.4876189238;4459.572936660237;4469.486009108994;4933.827316043921;5057.381637875918;5090.541851233407;5107.080725469451;5108.565771909355;5939.613925094855;5959.851003724942;5979.521638268928;5993.550483713739;5994.850128746729;1521.7793419954266;1528;1537.1238394115246;1547.9922600386926;1555.7821904933319;946.0019679238331;988.6786794291884;994.2046362909643;996.4569309726216;1009.7828966772179;5093.796248150033;5158.432572417031;5173.094708426011;5201.115810312256;5207.921881171786;5504.91742623861;5544;5563.887222555505;5566.35986861508;5581.6930068846605;4784.425868895685;5150.613703972217;5161.53546180838;5180.404253510819;5227.424983251839;2946.484365236075;2967.78320888439;2968.693774739108;2969.272528230554;2990.6710261871176;5454.8909021819345;5456.335817575598;5489.39616642177;5504.201890725903;5569.526590239875;5172.301739265226;5374.596905232123;5442.863928401822;5520.715174471184;5616.438356164351;5474.534664553478;5509;5512.724363781795;5542.944570554324;5578.497935185853;5250.606204534752;5423.945760542502;5427.918581221364;5452.618316717951;5469.304515600176;5222.7127507987425;5331.173668081454;5384.434634363335;5391;5895.9115613266695;6254.312025677263;6274.8431289216305;6280.434760871543;6282.277538083179;6292.370762923854;4430.933535997027;4447.398936382835;4447.444069491314;4457;4462.576055274743;6055.212822333068;6167.67395010057;6202.131701561695;6214.9689251553455;6304.369563043659;6017.157597936205;6046.637201767908;6055.576109672281;6075.845589338189;6081.756729730761;5892.383949567791;5902.61632993854;6047.274327080779;6060.757569697339;6068.966896089682;5823.98080335948;5894.587378883437;5901.498372638373;5961.970190149022;5967.134765459071;6040.6979651018155;6064.9393506066135;6089.147519347383;6089.1779609753885;6096.603720758137;5642.830715078554;5914.674692891932;5990.2212712348855;5991.820245392645;6001.969990150022 03:35:50 INFO - PROCESS | 21787 | |5;yui.html;781.8319061401801;791.7901756034648;806.6208881825544;876.465356132759;905.4386280506087;15027.098374097563;15032.549023529298;15439;15497.302621382036;16308.592285192875;14044.64888377791;14082.78875816861;14177.07848989815;14199.645008874782;14218.573442796707;738.3023043224156;854.5897968974896;878.4377998081233;886.7428445750725;891.728022952999;886.7827382291348;887.1217494680252;890.688259109313;894.5393122541897;894.7852515396323;931.4737173496986;932.0353434195575;933.10421994885;935.9625614975392;936.3539157981005;917.1745429113785;925.5927391947522;926.0322962504199;926.2266007883426;927.7124091531613;666.5634009723639;669.0232260899094;670.6076944987188;671.5869740109846;674.1539368093061;15443;15570.221488925508;15611.375544978187;15618;15678.921605392014;16068.517944461684;16380.180990950405;16567.50297491077;16573.751393729104;16859.747103793452;12961.546345877943;13043.934780326132;13159.342032898412;13170.473181072746;13296.534621288305;3888.475055867478;3941.664958478504;3942.4086387041884;3964.5242570891387;3995.0411901143516;87465;87727.56136219342;88327;88385.55807220923;90056.549717251;11764.117691173196;11878.346690932081;11911.225770324902;11953.282803031845;12072.879271207352;21692.89153554222;21899.233526826483;21970.231041913776;22060.669089963663;22086.77913220847;9213.262938965001;9409.670661526814;9423.434593924387;9519;9524.14282714559;4915.87710307238;4990.17662085759;5007.773423336191;5046.21783623539;5066.493350664904;3662.414013757786;3751.043483911585;3779.7354185207323;3792.3173828711097;3795.2978698940783;633.1673848888696;636.9808905732835;650.1061041068531;656.8784774816675;680.7855525509548;666.8099591616464;726.2737262737263;796.2753893956587;823.2138307915926;829.8464784014976;10116.71985735914;10364.481775911174;10682.145428365711;10790.298630588986;10873.510692018877;798.9001374828147;805.6173317674057;815.3232816762073;820.241276818952;820.3150369441584;4611.239145540948;4810;4811.975940120277;4889.193283108319;4891.3396691446915;79906;80535.19464805395;121806.3909680446;122173.38913305555;127977;107448;108140;109320.4533977325;109514.45242773894;109709.45145274382;77654.611726941;78444;94853.52573237228;95737;95862;9640.566174522022;9681;10072.345297555636;10202;10287.84568231492;41382.79308603438;46087.308690370344;48680.5131948676;48830;52007.219891702414;68247.65876170587;68281.65859170673;75117.24882751102;77599.61200193963;77638.61180694061;12758.170718903242;12807.93596032014;13123.212607243597;13444.731105377641;13784.724305514033;14816.40734370613;15167.393304267705;15277.6180595486;15423.922880385526;15483.84516154824;14112.364943577359;14304.713905722036;14364.425422982964;14717.92641036788;14816.925915370353;13460.326983650582;13682.589522314347;13877.930610346884;13919.373628186959;14041.36813843359;13588.184708917497;14103.858961410666;14834.777478337617;14901.776473352691;15030.62423439379;11011.61459348919;11228.550857965916;11370;11386.678835737504;11578.131640126856;11071.280366776135;11401;11416.885831141582;11507.309561426342;11555.191136620691 03:35:50 INFO - PROCESS | 21787 | __end_tp_report 03:35:50 INFO - PROCESS | 21787 | __start_cc_report 03:35:50 INFO - PROCESS | 21787 | _x_x_mozilla_cycle_collect,336 03:35:50 INFO - PROCESS | 21787 | __end_cc_report 03:35:50 INFO - PROCESS | 21787 | __startTimestamp1468492550683__endTimestamp 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | ------- Summary: start ------- 03:35:50 INFO - PROCESS | 21787 | Number of tests: 6 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#0] dojo.html Cycles:165 Average:5750.35 Median:5945.94 stddev:660.66 (11.1%) stddev-sans-first:634.75 03:35:50 INFO - PROCESS | 21787 | Values: 3327.2 3384.5 3384.5 3394.0 3407.6 5689.3 5693.8 5710.9 5796.9 5841.8 5796.6 5822.5 5839.5 5845.9 5876.2 5157.2 5200.1 5232.6 5253.4 5279.6 5068.2 5091.5 5153.0 5239.2 5294.4 5174.4 5204.6 5212.3 5224.6 5226.6 5229.6 5285.3 5300.7 5306.6 5315.8 5042.3 5157.4 5227.2 5272.8 5278.3 5616.0 5631.5 5644.1 5723.7 5731.0 6226.4 6258.3 6271.1 6283.0 6293.7 6047.2 6183.9 6295.4 6303.7 6336.5 5871.1 5888.3 5900.5 5905.4 5938.6 6462.6 6468.8 6486.8 6497.8 6503.3 5799.1 6020.2 6031.9 6204.7 6211.1 6227.1 6227.4 6231.2 6231.5 6239.3 6166.2 6205.1 6213.0 6230.5 6237.0 5936.1 6095.7 6111.6 6140.2 6184.2 4714.2 4735.5 4736.7 4755.3 4761.4 4201.3 4229.8 4240.8 4246.7 4259.1 5655.8 5804.6 5825.0 5868.7 5922.8 6119.7 6194.5 6199.4 6204.1 6207.0 5844.2 5893.0 5908.5 5924.1 5973.9 5194.6 5321.3 5347.4 5356.3 5373.1 6310.5 6334.9 6341.0 6343.5 6346.6 6030.6 6253.2 6253.3 6258.3 6269.9 6185.8 6233.0 6267.9 6380.4 6392.0 6213.8 6220.4 6224.2 6227.7 6233.0 5994.5 6125.8 6325.6 6326.8 6344.0 6005.7 6050.0 6090.0 6091.0 6125.8 6008.3 6053.2 6060.3 6065.2 6089.7 5688.0 5878.2 5901.9 5922.8 5986.9 6065.1 6107.3 6117.0 6123.0 6155.1 5942.0 5943.6 5945.9 5980.7 6004.2 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#1] ext.html Cycles:180 Average:60453.62 Median:43386.57 stddev:120492.63 (277.7%) stddev-sans-first:120746.76 03:35:50 INFO - PROCESS | 21787 | Values: 572.6 605.7 618.5 623.7 659.2 45738.8 47272.0 47363.3 49287.5 49706.8 46615.5 46833.8 46997.3 47110.8 47336.3 9051.3 9076.0 9135.6 9144.7 9186.0 9022.2 9055.4 9075.3 9114.3 9145.3 9119.8 9171.8 9195.2 9205.1 9207.6 9083.4 9088.5 9102.0 9149.4 9186.0 8966.4 8998.6 9021.6 9038.0 9072.2 43662.5 43928.8 44057.8 44118.0 44131.3 3362.0 3455.6 3672.4 4011.9 4118.3 33783.3 33880.0 34196.7 34233.5 34246.7 4661.4 4671.1 4681.1 4750.9 4811.3 334602.0 336897.0 337336.0 338139.0 339763.0 36964.0 37899.2 60352.4 60628.4 60698.0 39809.0 39852.8 39898.4 39963.4 40057.4 15220.7 15271.8 15301.3 15372.2 15384.3 12624.4 12655.6 12688.7 12702.0 12718.2 9105.0 9109.7 9129.1 9183.3 9200.0 3340.3 3454.7 3463.2 3467.7 3518.7 1071.4 1115.4 1121.1 1129.5 1208.4 32321.7 32655.5 32991.0 33133.3 33651.2 1091.9 1127.3 1139.4 1209.6 1245.7 16868.2 16895.9 16909.4 16955.9 17169.9 543458.0 543921.0 547914.0 548015.0 548850.0 62546.7 62856.4 63308.7 63358.0 63478.4 1428.2 1436.7 1456.7 1465.8 1471.3 30616.8 31025.5 31296.4 31606.2 31961.7 52431.7 52453.5 52558.5 52563.0 52567.2 445787.0 452342.0 454925.0 456275.0 456669.0 30201.1 30408.8 30720.4 30893.2 30956.5 51134.5 51147.5 51686.7 52104.5 52513.2 42775.0 43249.6 43523.6 44263.1 44796.6 42734.4 42762.7 43112.8 43172.6 44406.6 37166.8 42493.8 42749.8 43796.8 44291.0 38105.6 38214.2 38360.8 38598.0 39450.8 28876.4 29344.3 29621.7 29810.4 29993.4 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#2] jquery.html Cycles:180 Average:27816.54 Median:13456.13 stddev:74994.05 (557.3%) stddev-sans-first:75176.23 03:35:50 INFO - PROCESS | 21787 | Values: 423.6 424.9 428.1 432.1 440.7 18963.6 19424.8 19939.2 21033.7 21040.7 17111.9 18264.9 19785.7 20535.3 20566.9 5695.8 5861.8 5886.8 5911.2 5917.1 5782.4 5865.7 5870.2 5937.6 5952.5 5802.6 5836.7 5882.9 5886.4 5893.9 5653.4 5836.7 5852.4 5854.3 5882.5 5263.4 5301.3 5313.3 5325.3 5342.3 22957.9 23749.8 23750.9 23843.6 24311.1 2601.1 2637.2 2660.1 2850.6 2937.2 15114.5 15312.5 15468.4 15505.5 15662.0 2026.6 2103.0 2128.9 2129.1 2185.5 75893.6 80133.0 80405.0 80638.0 80739.6 11195.6 11255.4 11387.0 11429.5 11498.3 16412.8 16475.7 16487.9 16517.1 16543.8 8178.8 8187.5 8195.2 8347.0 8425.3 7673.2 7729.3 7755.9 7805.3 7896.6 7109.3 7118.2 7138.8 7216.8 7220.6 2028.4 2035.5 2037.2 2047.3 2073.1 993.4 999.3 1007.0 1024.7 1174.9 17815.3 19358.0 19836.0 20074.6 20193.1 1002.9 1044.6 1055.3 1102.5 1115.3 10845.7 11350.1 11391.0 11547.7 11577.2 379958.0 470030.0 471429.0 474989.0 477783.0 75325.6 77866.6 80162.0 80735.0 80874.6 1063.6 1073.3 1086.5 1103.7 1106.6 17358.9 17603.2 17634.1 17814.6 17943.8 27942.6 39240.6 39450.6 39589.6 39967.4 51828.2 52917.7 53469.7 53513.5 53539.5 9060.5 9083.3 9281.8 9325.5 9499.6 13437.3 13731.9 13792.2 13864.5 14116.6 12139.7 12263.9 12299.2 12395.0 12563.1 12185.7 12219.8 12303.6 12430.4 12480.6 9641.7 12505.2 12566.4 12662.3 12706.7 8251.8 8548.9 9180.1 9183.7 9311.7 9675.4 12203.3 12223.4 12637.6 12703.6 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#3] mootools.html Cycles:180 Average:6446.69 Median:4676.03 stddev:3757.62 (80.4%) stddev-sans-first:3750.29 03:35:50 INFO - PROCESS | 21787 | Values: 1569.7 1596.2 1809.5 1873.7 1912.6 8782.8 9463.9 9501.2 10130.3 10196.6 9617.9 9784.3 9914.5 9939.1 10003.3 2531.7 2553.4 2569.9 2573.9 2577.8 2463.6 2546.9 2548.3 2558.5 2562.9 2485.5 2493.8 2532.7 2533.5 2535.9 2404.5 2437.3 2448.2 2452.7 2472.6 2509.9 2517.7 2525.1 2526.5 2562.3 9764.3 9856.9 9903.0 9927.8 9947.1 5793.4 5958.6 6039.1 6039.6 6039.7 3628.3 3734.2 3799.1 3802.1 3809.5 1232.3 1239.4 1253.5 1263.8 1328.0 13971.7 13992.4 14010.6 14062.9 14095.2 5158.0 5205.9 5269.9 5297.2 5349.8 11836.6 11860.8 11887.1 11923.8 11967.3 5939.2 5945.9 5947.2 5966.3 5972.1 4777.8 5130.7 5166.8 5373.6 5380.9 4368.1 4481.8 4542.7 4554.3 4574.2 1345.2 1357.3 1370.3 1375.4 1391.4 931.5 997.7 1004.3 1016.4 1021.2 6251.6 6279.1 6409.6 6525.6 6598.7 499.6 502.3 504.3 506.6 514.9 4257.8 4320.7 4393.5 4412.6 4463.8 11700.4 11993.3 12289.7 12436.6 12472.3 12231.1 12323.2 12324.3 12379.4 12425.0 8771.8 9019.7 9127.7 9141.7 9415.5 6180.4 6243.2 6344.2 6375.8 6466.6 10521.6 10837.7 10984.7 11387.1 11393.6 11147.7 11204.7 11230.0 11293.7 11296.5 8364.0 9181.0 9395.6 9463.4 9685.3 9670.4 9727.3 9743.2 9767.7 9771.5 8094.2 8443.8 8516.1 8591.8 8613.7 8336.6 8419.1 8441.2 8487.7 8559.1 7680.9 7714.5 7772.0 7780.5 7783.2 5466.7 5500.8 5613.9 5702.2 5704.5 5408.8 5477.6 5601.8 5658.5 5664.3 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#4] prototype.html Cycles:180 Average:4874.40 Median:5425.93 stddev:1409.60 (26.0%) stddev-sans-first:1372.25 03:35:50 INFO - PROCESS | 21787 | Values: 361.6 364.7 366.6 367.6 370.1 5781.8 5796.4 5814.7 5834.1 5843.2 5308.2 5667.6 5683.3 5699.9 5707.3 4361.6 4376.2 4390.9 4391.7 4392.6 4416.5 4430.4 4432.0 4440.9 4462.9 4364.0 4433.7 4437.7 4461.2 4472.0 4324.3 4349.1 4352.2 4390.5 4408.4 3851.6 3870.6 3893.7 3899.5 3910.6 5423.4 5428.5 5449.8 5450.5 5462.7 4994.0 5058.7 5070.4 5070.8 5086.6 5898.6 5920.1 5964.7 5967.9 5976.9 4261.2 4269.0 4315.7 4336.6 4352.2 5956.9 6056.0 6134.3 6163.9 6229.9 4368.0 4376.1 4376.6 4376.7 4389.6 4397.3 4446.7 4455.5 4459.6 4469.5 4933.8 5057.4 5090.5 5107.1 5108.6 5939.6 5959.9 5979.5 5993.6 5994.9 1521.8 1528.0 1537.1 1548.0 1555.8 946.0 988.7 994.2 996.5 1009.8 5093.8 5158.4 5173.1 5201.1 5207.9 5504.9 5544.0 5563.9 5566.4 5581.7 4784.4 5150.6 5161.5 5180.4 5227.4 2946.5 2967.8 2968.7 2969.3 2990.7 5454.9 5456.3 5489.4 5504.2 5569.5 5172.3 5374.6 5442.9 5520.7 5616.4 5474.5 5509.0 5512.7 5542.9 5578.5 5250.6 5423.9 5427.9 5452.6 5469.3 5222.7 5331.2 5384.4 5391.0 5895.9 6254.3 6274.8 6280.4 6282.3 6292.4 4430.9 4447.4 4447.4 4457.0 4462.6 6055.2 6167.7 6202.1 6215.0 6304.4 6017.2 6046.6 6055.6 6075.8 6081.8 5892.4 5902.6 6047.3 6060.8 6069.0 5824.0 5894.6 5901.5 5962.0 5967.1 6040.7 6064.9 6089.1 6089.2 6096.6 5642.8 5914.7 5990.2 5991.8 6002.0 03:35:50 INFO - PROCESS | 21787 | 03:35:50 INFO - PROCESS | 21787 | [#5] yui.html Cycles:180 Average:21397.95 Median:3841.89 stddev:30796.47 (801.6%) stddev-sans-first:30843.95 03:35:50 INFO - PROCESS | 21787 | Values: 781.8 791.8 806.6 876.5 905.4 15027.1 15032.5 15439.0 15497.3 16308.6 14044.6 14082.8 14177.1 14199.6 14218.6 738.3 854.6 878.4 886.7 891.7 886.8 887.1 890.7 894.5 894.8 931.5 932.0 933.1 936.0 936.4 917.2 925.6 926.0 926.2 927.7 666.6 669.0 670.6 671.6 674.2 15443.0 15570.2 15611.4 15618.0 15678.9 16068.5 16380.2 16567.5 16573.8 16859.7 12961.5 13043.9 13159.3 13170.5 13296.5 3888.5 3941.7 3942.4 3964.5 3995.0 87465.0 87727.6 88327.0 88385.6 90056.5 11764.1 11878.3 11911.2 11953.3 12072.9 21692.9 21899.2 21970.2 22060.7 22086.8 9213.3 9409.7 9423.4 9519.0 9524.1 4915.9 4990.2 5007.8 5046.2 5066.5 3662.4 3751.0 3779.7 3792.3 3795.3 633.2 637.0 650.1 656.9 680.8 666.8 726.3 796.3 823.2 829.8 10116.7 10364.5 10682.1 10790.3 10873.5 798.9 805.6 815.3 820.2 820.3 4611.2 4810.0 4812.0 4889.2 4891.3 79906.0 80535.2 121806.4 122173.4 127977.0 107448.0 108140.0 109320.5 109514.5 109709.5 77654.6 78444.0 94853.5 95737.0 95862.0 9640.6 9681.0 10072.3 10202.0 10287.8 41382.8 46087.3 48680.5 48830.0 52007.2 68247.7 68281.7 75117.2 77599.6 77638.6 12758.2 12807.9 13123.2 13444.7 13784.7 14816.4 15167.4 15277.6 15423.9 15483.8 14112.4 14304.7 14364.4 14717.9 14816.9 13460.3 13682.6 13877.9 13919.4 14041.4 13588.2 14103.9 14834.8 14901.8 15030.6 11011.6 11228.6 11370.0 11386.7 11578.1 11071.3 11401.0 11416.9 11507.3 11555.2 03:35:50 INFO - PROCESS | 21787 | -------- Summary: end -------- 03:35:50 INFO - PROCESS | 21787 | 03:35:51 INFO - TEST-INFO | 21787: exit 0 03:35:51 INFO - TEST-OK | dromaeo_css | took 1110793ms 03:35:51 INFO - TEST-START | kraken 03:35:51 INFO - operating with platform_type : linux_ 03:35:51 INFO - Initialising browser for kraken test... 03:35:51 INFO - TEST-INFO | started process 22030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGlBWa_/profile http://localhost:56231/getInfo.html) 03:35:56 INFO - PROCESS | 22030 | __metrics Screen width/height:1600/1200 03:35:56 INFO - PROCESS | 22030 | colorDepth:24 03:35:56 INFO - PROCESS | 22030 | Browser inner width/height: 1024/697 03:35:56 INFO - PROCESS | 22030 | __metrics 03:35:56 ERROR - PROCESS | 22030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:35:57 INFO - TEST-INFO | 22030: exit 0 03:35:57 INFO - Browser initialized. 03:35:57 INFO - Running cycle 1/1 for kraken test... 03:35:57 INFO - TEST-INFO | started process 22162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGlBWa_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:09 INFO - PROCESS | 22162 | RSS: Main: 155521024 03:36:09 INFO - PROCESS | 22162 | 03:36:11 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56231/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:12 INFO - PROCESS | 22162 | RSS: Main: 160886784 03:36:12 INFO - PROCESS | 22162 | 03:36:15 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56231/tests/kraken/driver.html?testName=audio-dft) 03:36:16 INFO - PROCESS | 22162 | RSS: Main: 160747520 03:36:16 INFO - PROCESS | 22162 | 03:36:18 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56231/tests/kraken/driver.html?testName=audio-fft) 03:36:19 INFO - PROCESS | 22162 | RSS: Main: 161325056 03:36:19 INFO - PROCESS | 22162 | 03:36:21 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56231/tests/kraken/driver.html?testName=audio-oscillator) 03:36:22 INFO - PROCESS | 22162 | RSS: Main: 160702464 03:36:22 INFO - PROCESS | 22162 | 03:36:24 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:25 INFO - PROCESS | 22162 | RSS: Main: 160886784 03:36:25 INFO - PROCESS | 22162 | 03:36:28 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56231/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:28 INFO - PROCESS | 22162 | RSS: Main: 160473088 03:36:28 INFO - PROCESS | 22162 | 03:36:32 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56231/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:32 INFO - PROCESS | 22162 | RSS: Main: 161144832 03:36:32 INFO - PROCESS | 22162 | 03:36:35 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56231/tests/kraken/driver.html?testName=json-parse-financial) 03:36:36 INFO - PROCESS | 22162 | RSS: Main: 160518144 03:36:36 INFO - PROCESS | 22162 | 03:36:37 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:38 INFO - PROCESS | 22162 | RSS: Main: 160993280 03:36:38 INFO - PROCESS | 22162 | 03:36:40 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:40 INFO - PROCESS | 22162 | RSS: Main: 160997376 03:36:40 INFO - PROCESS | 22162 | 03:36:42 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:43 INFO - PROCESS | 22162 | RSS: Main: 161116160 03:36:43 INFO - PROCESS | 22162 | 03:36:46 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:46 INFO - PROCESS | 22162 | RSS: Main: 161366016 03:36:46 INFO - PROCESS | 22162 | 03:36:49 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:50 INFO - PROCESS | 22162 | RSS: Main: 161267712 03:36:50 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | Cycle 1(1): loaded http://localhost:56231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56231/tests/kraken/driver.html?testName=ai-astar) 03:36:51 INFO - PROCESS | 22162 | RSS: Main: 161992704 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | __start_tp_report 03:36:51 INFO - PROCESS | 22162 | _x_x_mozilla_page_load 03:36:51 INFO - PROCESS | 22162 | _x_x_mozilla_page_load_details 03:36:51 INFO - PROCESS | 22162 | |i|pagename|runs| 03:36:51 INFO - PROCESS | 22162 | |0;ai-astar;112;105;112;110;110;113;111;109;111;111 03:36:51 INFO - PROCESS | 22162 | |1;audio-beat-detection;157;126;153;181;124;158;173;126;186;125 03:36:51 INFO - PROCESS | 22162 | |2;audio-dft;163;162;164;162;164;162;162;160;160;164 03:36:51 INFO - PROCESS | 22162 | |3;audio-fft;76;77;75;173;76;75;75;77;180;76 03:36:51 INFO - PROCESS | 22162 | |4;audio-oscillator;87;89;148;85;85;85;135;85;84;143 03:36:51 INFO - PROCESS | 22162 | |5;imaging-gaussian-blur;117;116;117;117;117;118;117;119;118;118 03:36:51 INFO - PROCESS | 22162 | |6;imaging-darkroom;147;147;151;147;147;149;148;147;147;146 03:36:51 INFO - PROCESS | 22162 | |7;imaging-desaturate;96;96;98;95;95;95;96;97;95;96 03:36:51 INFO - PROCESS | 22162 | |8;json-parse-financial;52;53;54;53;53;53;55;54;53;64 03:36:51 INFO - PROCESS | 22162 | |9;json-stringify-tinderbox;60;61;61;60;60;59;60;60;59;59 03:36:51 INFO - PROCESS | 22162 | |10;stanford-crypto-aes;77;76;76;76;75;83;77;77;107;80 03:36:51 INFO - PROCESS | 22162 | |11;stanford-crypto-ccm;124;119;127;121;120;122;140;119;138;134 03:36:51 INFO - PROCESS | 22162 | |12;stanford-crypto-pbkdf2;156;155;155;155;160;159;162;156;154;158 03:36:51 INFO - PROCESS | 22162 | |13;stanford-crypto-sha256-iterative;64;64;63;67;62;66;62;62;63;62 03:36:51 INFO - PROCESS | 22162 | __end_tp_report 03:36:51 INFO - PROCESS | 22162 | __start_cc_report 03:36:51 INFO - PROCESS | 22162 | _x_x_mozilla_cycle_collect,868 03:36:51 INFO - PROCESS | 22162 | __end_cc_report 03:36:51 INFO - PROCESS | 22162 | __startTimestamp1468492611887__endTimestamp 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | ------- Summary: start ------- 03:36:51 INFO - PROCESS | 22162 | Number of tests: 14 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.22 (2.0%) stddev-sans-first:2.28 03:36:51 INFO - PROCESS | 22162 | Values: 112.0 105.0 112.0 110.0 110.0 113.0 111.0 109.0 111.0 111.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:157.50 stddev:24.39 (15.5%) stddev-sans-first:25.77 03:36:51 INFO - PROCESS | 22162 | Values: 157.0 126.0 153.0 181.0 124.0 158.0 173.0 126.0 186.0 125.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.56 03:36:51 INFO - PROCESS | 22162 | Values: 163.0 162.0 164.0 162.0 164.0 162.0 162.0 160.0 160.0 164.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:42.47 (55.9%) stddev-sans-first:44.42 03:36:51 INFO - PROCESS | 22162 | Values: 76.0 77.0 75.0 173.0 76.0 75.0 75.0 77.0 180.0 76.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:85.00 stddev:27.40 (32.2%) stddev-sans-first:28.47 03:36:51 INFO - PROCESS | 22162 | Values: 87.0 89.0 148.0 85.0 85.0 85.0 135.0 85.0 84.0 143.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 03:36:51 INFO - PROCESS | 22162 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.50 03:36:51 INFO - PROCESS | 22162 | Values: 147.0 147.0 151.0 147.0 147.0 149.0 148.0 147.0 147.0 146.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 03:36:51 INFO - PROCESS | 22162 | Values: 96.0 96.0 98.0 95.0 95.0 95.0 96.0 97.0 95.0 96.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:3.47 (6.5%) stddev-sans-first:3.57 03:36:51 INFO - PROCESS | 22162 | Values: 52.0 53.0 54.0 53.0 53.0 53.0 55.0 54.0 53.0 64.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 03:36:51 INFO - PROCESS | 22162 | Values: 60.0 61.0 61.0 60.0 60.0 59.0 60.0 60.0 59.0 59.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:10.15 03:36:51 INFO - PROCESS | 22162 | Values: 77.0 76.0 76.0 76.0 75.0 83.0 77.0 77.0 107.0 80.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:125.50 stddev:8.04 (6.4%) stddev-sans-first:8.49 03:36:51 INFO - PROCESS | 22162 | Values: 124.0 119.0 127.0 121.0 120.0 122.0 140.0 119.0 138.0 134.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:2.62 (1.7%) stddev-sans-first:2.76 03:36:51 INFO - PROCESS | 22162 | Values: 156.0 155.0 155.0 155.0 160.0 159.0 162.0 156.0 154.0 158.0 03:36:51 INFO - PROCESS | 22162 | 03:36:51 INFO - PROCESS | 22162 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.78 (2.8%) stddev-sans-first:1.88 03:36:51 INFO - PROCESS | 22162 | Values: 64.0 64.0 63.0 67.0 62.0 66.0 62.0 62.0 63.0 62.0 03:36:51 INFO - PROCESS | 22162 | -------- Summary: end -------- 03:36:51 INFO - PROCESS | 22162 | 03:36:52 INFO - TEST-INFO | 22162: exit 0 03:36:52 INFO - TEST-OK | kraken | took 61464ms 03:36:52 INFO - SUITE-END | took 1172s 03:36:53 INFO - Completed test suite (00:19:32) 03:36:53 INFO - javascript benchmark 03:36:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7589.851687447301, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.2347360107174, 3384.458486642138, 3384.543086683297, 3393.9999999999986, 3407.625161232266, 5689.345725241598, 5693.772249110036, 5710.885782284357, 5796.913046304308, 5841.766329346821, 5796.623219490741, 5822.505087067604, 5839.474447299742, 5845.85385365365, 5876.206712093866, 5157.174852023686, 5200.08998425276, 5232.633715639907, 5253.369595648527, 5279.577633789288, 5068.1890897456415, 5091.490850914916, 5152.974235128819, 5239.21411788231, 5294.4176140624695, 5174.404943431516, 5204.635675502716, 5212.348456442945, 5224.63427560071, 5226.608004399666, 5229.60777941654, 5285.2600635911, 5300.655457395257, 5306.575473962073, 5315.813946511854, 5042.319286896259, 5157.355330583677, 5227.18978558324, 5272.762725677354, 5278.340207474066, 5615.971920140414, 5631.521320687746, 5644.125160600072, 5723.685197314146, 5730.971345143289, 6226.377362263737, 6258.280297765724, 6271.122042913996, 6282.994720844688, 6293.653849038301, 6047.244094488189, 6183.87632247357, 6295.401936815995, 6303.653299068549, 6336.524760642924, 5871.1193321001765, 5888.293404791452, 5900.468957793819, 5905.350411454737, 5938.613990090674, 6462.644554549545, 6468.8059358219325, 6486.837829054311, 6497.805065848032, 6503.349665033459, 5799.130130480462, 6020.157177995085, 6031.939680603138, 6204.689765511706, 6211.09939058834, 6227.1282020517165, 6227.377262273827, 6231.158793562811, 6231.532635052298, 6239.282482514569, 6166.167567378437, 6205.100260462298, 6212.968935155386, 6230.501559875199, 6237.03325984464, 5936.1095835625, 6095.664738439428, 6111.591738512148, 6140.2017737694705, 6184.226971628546, 4714.175019371596, 4735.479097299294, 4736.715797052119, 4755.286706993909, 4761.40482439695, 4201.264778663783, 4229.809658565372, 4240.787960601958, 4246.745195288293, 4259.105587826529, 5655.773769049274, 5804.593678442468, 5824.970875145682, 5868.706564671835, 5922.763089476372, 6119.663418511936, 6194.535409844189, 6199.442050215412, 6204.13142160098, 6207.037909124093, 5844.1818145459665, 5893.027650437715, 5908.505090266094, 5924.052151655715, 5973.880522389528, 5194.6104042196985, 5321.3348331458565, 5347.385050719139, 5356.276902618097, 5373.140297552372, 6310.495160387158, 6334.873302533923, 6341.048842673636, 6343.460805831463, 6346.619202847844, 6030.6080104793045, 6253.187085678833, 6253.280872699606, 6258.280297765815, 6269.937300627118, 6185.84535386619, 6232.968835155795, 6267.874642507216, 6380.3619638035825, 6392.0, 6213.782517612042, 6220.440160385587, 6224.190855188977, 6227.719752611234, 6233.0338797486465, 5994.490468310242, 6125.754969801158, 6325.620462772248, 6326.810195694136, 6344.048392741126, 6005.669688167192, 6050.031994880798, 6089.969550152221, 6090.969545152246, 6125.785597504066, 6008.339082700987, 6053.182820319201, 6060.333363329942, 6065.2418447694035, 6089.725962331617, 5688.004599195207, 5878.177055212359, 5901.940980590139, 5922.822315330547, 5986.940130598812, 6065.090236464565, 6107.267127944675, 6116.97620400545, 6122.969385153046, 6155.076738489262, 5942.049272116441, 5943.613665111754, 5945.940540594539, 5980.671063091571, 6004.189434426296], "value": 5705.737716730188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5877368294827, 605.7037938810945, 618.5330075792773, 623.6663385088979, 659.1793217444283, 45738.77130614346, 47272.0, 47363.28955065672, 49287.50712492874, 49706.75146624262, 46615.53384466154, 46833.76583117079, 46997.29504057442, 47110.76444617772, 47336.289955650696, 9051.32115091369, 9075.954620226923, 9135.588898499584, 9144.725658230263, 9186.035466276046, 9022.233110185642, 9055.411398259124, 9075.273978081737, 9114.270858331318, 9145.314101442385, 9119.817603647924, 9171.816563668723, 9195.172434480895, 9205.125513076247, 9207.585658645343, 9083.364164508486, 9088.50013249271, 9102.044285350075, 9149.359544831832, 9186.0, 8966.417182883091, 8998.59506322217, 9021.594028268679, 9038.0, 9072.228860546862, 43662.47181348669, 43928.78035609834, 44057.77971110156, 44118.0, 44131.338029929255, 3361.966380336214, 3455.6026057003264, 3672.4307732301536, 4011.939820902689, 4118.279301122292, 33783.32433351344, 33880.0, 34196.658033419844, 34233.48649770256, 34246.65753342459, 4661.394018777572, 4671.135839869635, 4681.1105889881155, 4750.928736068961, 4811.326414302001, 334602.0, 336897.0, 337336.0, 338139.0, 339763.0, 36964.0, 37899.24201515954, 60352.39647603468, 60628.39371606227, 60698.0, 39809.00477488086, 39852.800735996134, 39898.40152397716, 39963.40054899179, 40057.399139012356, 15220.695586088215, 15271.847281527265, 15301.311440985182, 15372.231388430533, 15384.307706153026, 12624.368781560885, 12655.620331390073, 12688.746225075447, 12702.0, 12718.173318734252, 9105.0, 9109.681161159328, 9129.08709129095, 9183.31125165602, 9200.0, 3340.315235376742, 3454.7408944329277, 3463.1861512544533, 3467.687908088284, 3518.7185025197923, 1071.421432426481, 1115.3753897817248, 1121.1479275750326, 1129.4647752534515, 1208.3656080557778, 32321.676783231866, 32655.530501127505, 32991.0, 33133.3373332532, 33651.15872103217, 1091.901728844392, 1127.3067063755896, 1139.418896362861, 1209.564556759566, 1245.6761242076943, 16868.24092915822, 16895.915520422564, 16909.408170713967, 16955.915220424067, 17169.91415042917, 543458.0, 543921.0, 547914.0, 548015.0, 548850.0, 62546.68726656338, 62856.37143628505, 63308.683456582425, 63358.0, 63478.36521634817, 1428.2358937968138, 1436.6623843396794, 1456.7377871983144, 1465.772805215172, 1471.2570152073135, 30616.84691576528, 31025.534616981215, 31296.374072518876, 31606.209844753146, 31961.6803831968, 52431.73784131055, 52453.47546524639, 52558.47441525689, 52563.0, 52567.211491826885, 445787.0, 452342.0, 454925.0, 456275.0, 456669.0, 30201.09396718102, 30408.84795576008, 30720.385592288476, 30893.227669308446, 30956.535651964787, 51134.48865511446, 51147.48852511427, 51686.74156629193, 52104.47895520996, 52513.21230181627, 42775.0, 43249.56750432456, 43523.56476435195, 44263.11473770571, 44796.55203447924, 42734.35898461588, 42762.715494698314, 43112.78443607762, 43172.56827431686, 44406.55593444154, 37166.81416593008, 42493.787531062146, 42749.786251068545, 43796.78101609471, 44291.0, 38105.61894381021, 38214.23571528609, 38360.80819595884, 38598.0, 39450.80274598609, 28876.42247155003, 29344.266393339483, 29621.703782961893, 29810.403791923607, 29993.400131997674], "value": 19674.063372129487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.58911855500173, 424.8916526285797, 428.0988519167153, 432.1184783042593, 440.6871121503732, 18963.62072758544, 19424.805751942476, 19939.202431902726, 21033.68449473259, 21040.684389734168, 17111.91444042778, 18264.908675456638, 19785.703214451794, 20535.28126515572, 20566.89716551419, 5695.77216911323, 5861.7948371807, 5886.823395298148, 5911.201987731666, 5917.142014407908, 5782.392848750884, 5865.706714664271, 5870.207521984542, 5937.614055086406, 5952.494038006775, 5802.564807639423, 5836.6789826559525, 5882.911756323659, 5886.440788125121, 5893.911591326134, 5653.406392328808, 5836.737346819404, 5852.414758524156, 5854.268216472941, 5882.499987501024, 5263.421023687391, 5301.284326615896, 5313.282706834605, 5325.254464374991, 5342.332208473941, 22957.885210574008, 23749.762502374928, 23750.881245593835, 23843.642345364835, 24311.14910978125, 2601.1026195962554, 2637.1824734332226, 2660.0822716162893, 2850.586664933573, 2937.221636266391, 15114.470993515175, 15312.540623781193, 15468.381264749396, 15505.534833955, 15662.0, 2026.5642886779412, 2102.9894850525648, 2128.9148434062618, 2129.1483406637312, 2185.4536365908525, 75893.62053189754, 80133.0, 80405.0, 80638.0, 80739.59630201811, 11195.60815371458, 11255.43722813856, 11387.0, 11429.542818287342, 11498.310101393776, 16412.75380869288, 16475.6704865902, 16487.917560412123, 16517.091559964316, 16543.83456165423, 8178.754637360888, 8187.549684767395, 8195.221453961864, 8346.998360196816, 8425.325973922072, 7673.194314596887, 7729.265719756614, 7755.883661745078, 7805.33654639362, 7896.644650990719, 7109.253528379549, 7118.220444888778, 7138.785836424916, 7216.819579510554, 7220.602866842374, 2028.3610662641515, 2035.4809523571394, 2037.215671966274, 2047.2527527452671, 2073.139647046489, 993.3642468819961, 999.3454287441738, 1007.0030669637154, 1024.6925922223304, 1174.9236299640495, 17815.287388504574, 19358.0, 19836.0, 20074.598508029758, 20193.091310891046, 1002.8746406699163, 1044.5926088825365, 1055.2613170780485, 1102.4928532874808, 1115.3085087245797, 10845.728856778485, 11350.14873884462, 11391.0, 11547.653570392902, 11577.247478914012, 379958.0, 470030.0, 471429.0, 474989.0, 477783.0, 75325.62337188389, 77866.61066694744, 80162.0, 80735.0, 80874.59562702266, 1063.638362956583, 1073.3238060022293, 1086.4947799273375, 1103.6854496468468, 1106.645873320546, 17358.91320543389, 17603.207855646782, 17634.118294084987, 17814.554636134202, 17943.820561794215, 27942.58086128669, 39240.6075939237, 39450.60549394584, 39589.60410395974, 39967.400488992105, 51828.22257666063, 52917.7354113227, 53469.7326513365, 53513.46486535085, 53539.464605353445, 9060.456372617664, 9083.318751093562, 9281.767955801159, 9325.487098209664, 9499.62001519959, 13437.260950647807, 13731.931340343235, 13792.241426721626, 13864.514741983981, 14116.647083822987, 12139.696507587381, 12263.9386803069, 12299.200551964093, 12395.0, 12563.120581559204, 12185.69535761613, 12219.816702749644, 12303.630891073282, 12430.37848107573, 12480.625581232578, 9641.662541811003, 12505.249685018927, 12566.37168141571, 12662.303573303558, 12706.682332941751, 8251.83496330082, 8548.914510854811, 9180.127887850644, 9183.678571249975, 9311.674091406769, 9675.371100878421, 12203.328816915155, 12223.388830558259, 12637.620871373874, 12703.618891433272], "value": 9625.450272697455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.74884018557, 1596.1859451679643, 1809.4842969753615, 1873.672107381208, 1912.5887934094158, 8782.824343513126, 9463.905360946388, 9501.239900807936, 10130.341527800698, 10196.592136314539, 9617.903820961788, 9784.266180036508, 9914.504274786268, 9939.105480506752, 10003.349782264148, 2531.7215106338335, 2553.4127150755244, 2569.871506424681, 2573.858437785921, 2577.8324408913454, 2463.59350707134, 2546.898124075035, 2548.2610043087484, 2558.5010922870047, 2562.9102981395654, 2485.490474452742, 2493.7880280176205, 2532.708738495069, 2533.5312967101145, 2535.8858851351642, 2404.5431368040104, 2437.2810021043833, 2448.2288079254977, 2452.6811514503, 2472.554940110779, 2509.912153074634, 2517.6727025486753, 2525.053105085593, 2526.5325914705836, 2562.3466016165758, 9764.316497845153, 9856.90143098567, 9902.950485247527, 9927.751806204831, 9947.10476057151, 5793.420657934215, 5958.5828991970575, 6039.063945088518, 6039.5772295939305, 6039.698015099228, 3628.310620982005, 3734.178480734234, 3799.126200973764, 3802.0874990002476, 3809.5238095238096, 1232.2668012532529, 1239.3865036806749, 1253.523661008811, 1263.8420197475316, 1327.9535216267384, 13971.720565588632, 13992.440302387893, 14010.649733756636, 14062.92968535161, 14095.22476263805, 5158.0, 5205.869853253699, 5269.947300527022, 5297.152455607084, 5349.812756553502, 11836.644900652995, 11860.76278474443, 11887.108466864847, 11923.821142682868, 11967.341796201119, 5939.227900372924, 5945.910811337833, 5947.167396564484, 5966.343702192756, 5972.074328479092, 4777.808887644455, 5130.692158470503, 5166.819161329336, 5373.596980226421, 5380.91928621071, 4368.082702632482, 4481.820727170877, 4542.659300552472, 4554.316852472156, 4574.245249533857, 1345.206328266308, 1357.2942070123677, 1370.2669072046408, 1375.4291968832822, 1391.3669280477359, 931.5202670624634, 997.7256254530063, 1004.3120462483222, 1016.3749294184172, 1021.1779517488493, 6251.562390632612, 6279.0895320178315, 6409.583377080475, 6525.608463492111, 6598.73605055802, 499.60531180367104, 502.30932467856695, 504.28139900642174, 506.6478797235959, 514.9330587023663, 4257.765822879709, 4320.740755554677, 4393.538678438782, 4412.580804823537, 4463.843765468193, 11700.35648039366, 11993.340366279765, 12289.69275768095, 12436.626901192978, 12472.251664900135, 12231.143819932518, 12323.198992065667, 12324.32216228116, 12379.442925068393, 12425.0, 8771.780705482413, 9019.684311049083, 9127.680531181377, 9141.680041198526, 9415.482148481762, 6180.351063138306, 6243.157173781663, 6344.175257216532, 6375.776847810304, 6466.612003279818, 10521.579136834442, 10837.729056773644, 10984.670459886216, 11387.089032877515, 11393.601223957121, 11147.665570032912, 11204.66386008421, 11230.0, 11293.71765705864, 11296.49165787525, 8363.95818020906, 9180.954095229748, 9395.577199026196, 9463.432194068379, 9685.32202745801, 9670.371425857296, 9727.270454715783, 9743.171830394496, 9767.658131965347, 9771.462569558742, 8094.190580942094, 8443.83112337762, 8516.063233044484, 8591.828163436572, 8613.655453782028, 8336.62485188156, 8419.115992820665, 8441.240288374076, 8487.745367638981, 8559.144085591392, 7680.884786728092, 7714.498557593738, 7771.961140194263, 7780.533168009937, 7783.182765809508, 5466.671999680032, 5500.7524661391135, 5613.943860561342, 5702.230198923092, 5704.458076482728, 5408.78364865401, 5477.616566840283, 5601.775928962796, 5658.462446067617, 5664.320281566238], "value": 5031.387498987387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.59862552566653, 364.67908240748136, 366.63702934095255, 367.5809577082127, 370.11727031030983, 5781.797637082703, 5796.391378905218, 5814.69169436877, 5834.095715164156, 5843.211166492522, 5308.203769434577, 5667.603267771257, 5683.261176047118, 5699.914501282484, 5707.343655479621, 4361.60745532902, 4376.234159022174, 4390.934135987971, 4391.736495810245, 4392.604665580097, 4416.470023597173, 4430.357598148266, 4431.980644451778, 4440.888977775549, 4462.933056004163, 4363.978180109095, 4433.689641725081, 4437.667174961891, 4461.1523810476065, 4472.038511719979, 4324.2648749712625, 4349.108432771274, 4352.216601011816, 4390.538993405694, 4408.360787685768, 3851.5763266040713, 3870.632289932452, 3893.7079719020903, 3899.53205615328, 3910.5502867170353, 5423.396769550638, 5428.511433970922, 5449.782008719647, 5450.547253735835, 5462.726863656841, 4993.975030124862, 5058.696478211319, 5070.416902056237, 5070.847874563769, 5086.618503612244, 5898.557608179361, 5920.141579470996, 5964.701764911737, 5967.880642387128, 5976.880462390772, 4261.169072030955, 4268.954106243959, 4315.676324275661, 4336.609705126553, 4352.151330490556, 5956.880862382728, 6055.9697201514155, 6134.263888333384, 6163.907541386883, 6229.906551401733, 4367.995361066973, 4376.102898905717, 4376.6498680105515, 4376.715513491613, 4389.561043895649, 4397.2964325707735, 4446.710963787408, 4455.4876189238, 4459.572936660237, 4469.486009108994, 4933.827316043921, 5057.381637875918, 5090.541851233407, 5107.080725469451, 5108.565771909355, 5939.613925094855, 5959.851003724942, 5979.521638268928, 5993.550483713739, 5994.850128746729, 1521.7793419954266, 1528.0, 1537.1238394115246, 1547.9922600386926, 1555.7821904933319, 946.0019679238331, 988.6786794291884, 994.2046362909643, 996.4569309726216, 1009.7828966772179, 5093.796248150033, 5158.432572417031, 5173.094708426011, 5201.115810312256, 5207.921881171786, 5504.91742623861, 5544.0, 5563.887222555505, 5566.35986861508, 5581.6930068846605, 4784.425868895685, 5150.613703972217, 5161.53546180838, 5180.404253510819, 5227.424983251839, 2946.484365236075, 2967.78320888439, 2968.693774739108, 2969.272528230554, 2990.6710261871176, 5454.8909021819345, 5456.335817575598, 5489.39616642177, 5504.201890725903, 5569.526590239875, 5172.301739265226, 5374.596905232123, 5442.863928401822, 5520.715174471184, 5616.438356164351, 5474.534664553478, 5509.0, 5512.724363781795, 5542.944570554324, 5578.497935185853, 5250.606204534752, 5423.945760542502, 5427.918581221364, 5452.618316717951, 5469.304515600176, 5222.7127507987425, 5331.173668081454, 5384.434634363335, 5391.0, 5895.9115613266695, 6254.312025677263, 6274.8431289216305, 6280.434760871543, 6282.277538083179, 6292.370762923854, 4430.933535997027, 4447.398936382835, 4447.444069491314, 4457.0, 4462.576055274743, 6055.212822333068, 6167.67395010057, 6202.131701561695, 6214.9689251553455, 6304.369563043659, 6017.157597936205, 6046.637201767908, 6055.576109672281, 6075.845589338189, 6081.756729730761, 5892.383949567791, 5902.61632993854, 6047.274327080779, 6060.757569697339, 6068.966896089682, 5823.98080335948, 5894.587378883437, 5901.498372638373, 5961.970190149022, 5967.134765459071, 6040.6979651018155, 6064.9393506066135, 6089.147519347383, 6089.1779609753885, 6096.603720758137, 5642.830715078554, 5914.674692891932, 5990.2212712348855, 5991.820245392645, 6001.969990150022], "value": 4431.447535752813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.8319061401801, 791.7901756034648, 806.6208881825544, 876.465356132759, 905.4386280506087, 15027.098374097563, 15032.549023529298, 15439.0, 15497.302621382036, 16308.592285192875, 14044.64888377791, 14082.78875816861, 14177.07848989815, 14199.645008874782, 14218.573442796707, 738.3023043224156, 854.5897968974896, 878.4377998081233, 886.7428445750725, 891.728022952999, 886.7827382291348, 887.1217494680252, 890.688259109313, 894.5393122541897, 894.7852515396323, 931.4737173496986, 932.0353434195575, 933.10421994885, 935.9625614975392, 936.3539157981005, 917.1745429113785, 925.5927391947522, 926.0322962504199, 926.2266007883426, 927.7124091531613, 666.5634009723639, 669.0232260899094, 670.6076944987188, 671.5869740109846, 674.1539368093061, 15443.0, 15570.221488925508, 15611.375544978187, 15618.0, 15678.921605392014, 16068.517944461684, 16380.180990950405, 16567.50297491077, 16573.751393729104, 16859.747103793452, 12961.546345877943, 13043.934780326132, 13159.342032898412, 13170.473181072746, 13296.534621288305, 3888.475055867478, 3941.664958478504, 3942.4086387041884, 3964.5242570891387, 3995.0411901143516, 87465.0, 87727.56136219342, 88327.0, 88385.55807220923, 90056.549717251, 11764.117691173196, 11878.346690932081, 11911.225770324902, 11953.282803031845, 12072.879271207352, 21692.89153554222, 21899.233526826483, 21970.231041913776, 22060.669089963663, 22086.77913220847, 9213.262938965001, 9409.670661526814, 9423.434593924387, 9519.0, 9524.14282714559, 4915.87710307238, 4990.17662085759, 5007.773423336191, 5046.21783623539, 5066.493350664904, 3662.414013757786, 3751.043483911585, 3779.7354185207323, 3792.3173828711097, 3795.2978698940783, 633.1673848888696, 636.9808905732835, 650.1061041068531, 656.8784774816675, 680.7855525509548, 666.8099591616464, 726.2737262737263, 796.2753893956587, 823.2138307915926, 829.8464784014976, 10116.71985735914, 10364.481775911174, 10682.145428365711, 10790.298630588986, 10873.510692018877, 798.9001374828147, 805.6173317674057, 815.3232816762073, 820.241276818952, 820.3150369441584, 4611.239145540948, 4810.0, 4811.975940120277, 4889.193283108319, 4891.3396691446915, 79906.0, 80535.19464805395, 121806.3909680446, 122173.38913305555, 127977.0, 107448.0, 108140.0, 109320.4533977325, 109514.45242773894, 109709.45145274382, 77654.611726941, 78444.0, 94853.52573237228, 95737.0, 95862.0, 9640.566174522022, 9681.0, 10072.345297555636, 10202.0, 10287.84568231492, 41382.79308603438, 46087.308690370344, 48680.5131948676, 48830.0, 52007.219891702414, 68247.65876170587, 68281.65859170673, 75117.24882751102, 77599.61200193963, 77638.61180694061, 12758.170718903242, 12807.93596032014, 13123.212607243597, 13444.731105377641, 13784.724305514033, 14816.40734370613, 15167.393304267705, 15277.6180595486, 15423.922880385526, 15483.84516154824, 14112.364943577359, 14304.713905722036, 14364.425422982964, 14717.92641036788, 14816.925915370353, 13460.326983650582, 13682.589522314347, 13877.930610346884, 13919.373628186959, 14041.36813843359, 13588.184708917497, 14103.858961410666, 14834.777478337617, 14901.776473352691, 15030.62423439379, 11011.61459348919, 11228.550857965916, 11370.0, 11386.678835737504, 11578.131640126856, 11071.280366776135, 11401.0, 11416.885831141582, 11507.309561426342, 11555.191136620691], "value": 7934.149872196766, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 110.0, 110.0, 113.0, 111.0, 109.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 153.0, 181.0, 124.0, 158.0, 173.0, 126.0, 186.0, 125.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 164.0, 162.0, 162.0, 160.0, 160.0, 164.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 173.0, 76.0, 75.0, 75.0, 77.0, 180.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 148.0, 85.0, 85.0, 85.0, 135.0, 85.0, 84.0, 143.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 55.0, 54.0, 53.0, 64.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 76.0, 75.0, 83.0, 77.0, 77.0, 107.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 119.0, 127.0, 121.0, 120.0, 122.0, 140.0, 119.0, 138.0, 134.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 155.0, 155.0, 160.0, 159.0, 162.0, 156.0, 154.0, 158.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 67.0, 62.0, 66.0, 62.0, 62.0, 63.0, 62.0], "value": 63.5, "unit": "score"}]}]} 03:36:53 INFO - Return code: 0 03:36:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:53 ERROR - # TBPL SUCCESS # 03:36:53 INFO - Running post-action listener: _resource_record_post_action 03:36:53 INFO - ##### 03:36:53 INFO - ##### Finished run-tests step (success) 03:36:53 INFO - ##### 03:36:53 INFO - Running post-run listener: _resource_record_post_run 03:36:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504496128; Read time: 216; Write time: 681700 03:36:53 INFO - TinderboxPrint: CPU usage
13.4% 03:36:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 216 03:36:53 INFO - TinderboxPrint: I/O write bytes / time
504,496,128 / 681,700 03:36:53 INFO - TinderboxPrint: CPU idle
8,217.1 (86.5%) 03:36:53 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 03:36:53 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:53 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259522560; Read time: 0; Write time: 443716 03:36:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 244973568; Read time: 216; Write time: 237984 03:36:53 INFO - Running post-run listener: _upload_blobber_files 03:36:53 INFO - Blob upload gear active. 03:36:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:53 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:36:53 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:36:53 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:36:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:55 INFO - (blobuploader) - INFO - Done attempting. 03:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:59 INFO - (blobuploader) - INFO - Done attempting. 03:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:59 INFO - (blobuploader) - INFO - Done attempting. 03:36:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:59 INFO - Return code: 0 03:36:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926fe938a8d3926f6c4d50c57f32fd0499d3ecf329c3825843c7cd5c028388a728ab8fc94bed60e69e1c3ee7948934a9a83509e7961ca62348e44253f33dff43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/764d3a2251bd5f1a331a91e70077d5b8b267a309417ef813341b0f6906d4b0b5617bb70553ff01d521d97d171cca92c4af698faa0dafe539f768cf704cb98d50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e96ae9c01360e34e668b8a35528fe9f02123640f13d852b2ceb2eda46f8589e0b991555875ff413349927e150844ac448f42ec1726e54acaabf952aadcb648fe"} 03:36:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:59 INFO - Contents: 03:36:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/926fe938a8d3926f6c4d50c57f32fd0499d3ecf329c3825843c7cd5c028388a728ab8fc94bed60e69e1c3ee7948934a9a83509e7961ca62348e44253f33dff43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/764d3a2251bd5f1a331a91e70077d5b8b267a309417ef813341b0f6906d4b0b5617bb70553ff01d521d97d171cca92c4af698faa0dafe539f768cf704cb98d50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e96ae9c01360e34e668b8a35528fe9f02123640f13d852b2ceb2eda46f8589e0b991555875ff413349927e150844ac448f42ec1726e54acaabf952aadcb648fe"} 03:36:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:59 INFO - Copying logs to upload dir... 03:36:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.623039 ========= master_lag: 170.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 22 secs) (at 2016-07-14 03:39:49.359261) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 03:39:49.362693) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 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/926fe938a8d3926f6c4d50c57f32fd0499d3ecf329c3825843c7cd5c028388a728ab8fc94bed60e69e1c3ee7948934a9a83509e7961ca62348e44253f33dff43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/764d3a2251bd5f1a331a91e70077d5b8b267a309417ef813341b0f6906d4b0b5617bb70553ff01d521d97d171cca92c4af698faa0dafe539f768cf704cb98d50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e96ae9c01360e34e668b8a35528fe9f02123640f13d852b2ceb2eda46f8589e0b991555875ff413349927e150844ac448f42ec1726e54acaabf952aadcb648fe"} build_url:https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/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/926fe938a8d3926f6c4d50c57f32fd0499d3ecf329c3825843c7cd5c028388a728ab8fc94bed60e69e1c3ee7948934a9a83509e7961ca62348e44253f33dff43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/764d3a2251bd5f1a331a91e70077d5b8b267a309417ef813341b0f6906d4b0b5617bb70553ff01d521d97d171cca92c4af698faa0dafe539f768cf704cb98d50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e96ae9c01360e34e668b8a35528fe9f02123640f13d852b2ceb2eda46f8589e0b991555875ff413349927e150844ac448f42ec1726e54acaabf952aadcb648fe"}' ========= master_lag: 1.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 03:39:50.829663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:39:50.829970) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468491385.468041-1041131570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:39:50.924612) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-14 03:39:50.924897) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-14 03:39:52.158349) ========= ========= Total master_lag: 171.61 =========