builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1468477358.4 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.400262) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.400954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.401601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.417762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.418202) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:22:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-07-13 23:22:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.548756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.549299) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.598877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:38.599274) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:22:38,960 truncating revision to first 12 chars 2016-07-13 23:22:38,960 Setting DEBUG logging. 2016-07-13 23:22:38,960 attempt 1/10 2016-07-13 23:22:38,960 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-13 23:22:39,313 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:39.342808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:39.343227) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:39.344082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:39.344537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:39.355540) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:22:39.355870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:39 INFO - MultiFileLogger online at 20160713 23:22:39 in /builds/slave/test 23:22:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:22:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:39 INFO - {'append_to_log': False, 23:22:39 INFO - 'base_work_dir': '/builds/slave/test', 23:22:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:22:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:39 INFO - 'branch': 'Mozilla-Aurora', 23:22:39 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:39 INFO - 'config_files': ('talos/linux_config.py',), 23:22:39 INFO - 'default_actions': ('clobber', 23:22:39 INFO - 'read-buildbot-config', 23:22:39 INFO - 'download-and-extract', 23:22:39 INFO - 'populate-webroot', 23:22:39 INFO - 'create-virtualenv', 23:22:39 INFO - 'install', 23:22:39 INFO - 'run-tests'), 23:22:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:39 INFO - 'download_minidump_stackwalk': True, 23:22:39 INFO - 'download_symbols': 'ondemand', 23:22:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:39 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:39 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:39 INFO - 'installer_path': 'installer.exe', 23:22:39 INFO - 'log_level': 'info', 23:22:39 INFO - 'log_name': 'talos', 23:22:39 INFO - 'log_to_console': True, 23:22:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:39 INFO - 'opt_config_files': (), 23:22:39 INFO - 'pip_index': False, 23:22:39 INFO - 'sps_profile': False, 23:22:39 INFO - 'sps_profile_interval': 0, 23:22:39 INFO - 'suite': 'dromaeojs', 23:22:39 INFO - 'system_bits': '32', 23:22:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:39 INFO - 'title': 'talos-linux64-ix-009', 23:22:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:39 INFO - 'use_talos_json': True, 23:22:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:39 INFO - 'work_dir': 'build'} 23:22:39 INFO - ##### 23:22:39 INFO - ##### Running clobber step. 23:22:39 INFO - ##### 23:22:39 INFO - Running pre-action listener: _resource_record_pre_action 23:22:39 INFO - Running main action method: clobber 23:22:39 INFO - rmtree: /builds/slave/test/build 23:22:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:40 INFO - Running post-action listener: _resource_record_post_action 23:22:40 INFO - ##### 23:22:40 INFO - ##### Finished clobber step (success) 23:22:40 INFO - ##### 23:22:40 INFO - ##### 23:22:40 INFO - ##### Running read-buildbot-config step. 23:22:40 INFO - ##### 23:22:40 INFO - Running pre-action listener: _resource_record_pre_action 23:22:40 INFO - Running main action method: read_buildbot_config 23:22:40 INFO - Using buildbot properties: 23:22:40 INFO - { 23:22:40 INFO - "project": "", 23:22:40 INFO - "product": "firefox", 23:22:40 INFO - "script_repo_revision": "production", 23:22:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:22:40 INFO - "repository": "", 23:22:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:22:40 INFO - "buildid": "20160713152443", 23:22:40 INFO - "pgo_build": "True", 23:22:40 INFO - "basedir": "/builds/slave/test", 23:22:40 INFO - "buildnumber": 606, 23:22:40 INFO - "slavename": "talos-linux64-ix-009", 23:22:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:22:40 INFO - "platform": "ubuntu64_hw", 23:22:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:22:40 INFO - "branch": "mozilla-aurora", 23:22:40 INFO - "repo_path": "releases/mozilla-aurora", 23:22:40 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 23:22:40 INFO - "stage_platform": "linux64-pgo", 23:22:40 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 23:22:40 INFO - "slavebuilddir": "test" 23:22:40 INFO - } 23:22:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:22:40 INFO - Running post-action listener: _resource_record_post_action 23:22:40 INFO - ##### 23:22:40 INFO - ##### Finished read-buildbot-config step (success) 23:22:40 INFO - ##### 23:22:40 INFO - ##### 23:22:40 INFO - ##### Running download-and-extract step. 23:22:40 INFO - ##### 23:22:40 INFO - Running pre-action listener: _resource_record_pre_action 23:22:40 INFO - Running main action method: download_and_extract 23:22:40 INFO - mkdir: /builds/slave/test/build/tests 23:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:40 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:40 INFO - Downloaded 1361 bytes. 23:22:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:40 INFO - Using the following test package requirements: 23:22:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:22:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'jsshell-linux-x86_64.zip'], 23:22:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:22:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:22:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:40 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:42 INFO - Downloaded 24491003 bytes. 23:22:42 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'] 23:22:42 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 23:22:43 INFO - Return code: 0 23:22:43 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 23:22:43 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')]} 23:22:43 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:44 INFO - Downloaded 24491003 bytes. 23:22:44 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'] 23:22:44 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 23:22:45 INFO - Return code: 0 23:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:45 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:46 INFO - Downloaded 10833369 bytes. 23:22:46 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'] 23:22:46 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 23:22:46 INFO - Return code: 0 23:22: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')]} 23:22:46 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:48 INFO - Downloaded 63642548 bytes. 23:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:48 INFO - mkdir: /builds/slave/test/properties 23:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:22:48 INFO - Contents: 23:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:48 INFO - Running post-action listener: _resource_record_post_action 23:22:48 INFO - Running post-action listener: set_extra_try_arguments 23:22:48 INFO - ##### 23:22:48 INFO - ##### Finished download-and-extract step (success) 23:22:48 INFO - ##### 23:22:48 INFO - ##### 23:22:48 INFO - ##### Running populate-webroot step. 23:22:48 INFO - ##### 23:22:48 INFO - Running pre-action listener: _resource_record_pre_action 23:22:48 INFO - Running main action method: populate_webroot 23:22:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:48 INFO - '--tppagecycles', 23:22:48 INFO - '7'], 23:22:48 INFO - 'tests': ['tsvgm']}}, 23:22:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:22:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:22:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['damp', 'tps']}, 23:22:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'tests': ['damp', 'tps']}, 23:22:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['dromaeo_dom']}, 23:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['a11yr', 23:22:48 INFO - 'ts_paint', 23:22:48 INFO - 'tpaint', 23:22:48 INFO - 'sessionrestore', 23:22:48 INFO - 'sessionrestore_no_auto_restore', 23:22:48 INFO - 'tabpaint']}, 23:22:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['tsvgx', 23:22:48 INFO - 'tsvgr_opacity', 23:22:48 INFO - 'tart', 23:22:48 INFO - 'tscrollx', 23:22:48 INFO - 'cart']}, 23:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:22:48 INFO - 'tsvgr_opacity', 23:22:48 INFO - 'tart', 23:22:48 INFO - 'tscrollx', 23:22:48 INFO - 'cart']}, 23:22:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'talos_options': ['--disable-e10s'], 23:22:48 INFO - 'tests': ['tp5o']}, 23:22:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'tests': ['tp5o']}, 23:22:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'talos_options': ['--disable-e10s', 23:22:48 INFO - '--xperf_path', 23:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:48 INFO - 'tests': ['tp5n']}, 23:22:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:48 INFO - 'talos_options': ['--xperf_path', 23:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:48 INFO - 'tests': ['tp5n']}}, 23:22:48 INFO - 'talos.zip': {'path': '', 23:22:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:48 INFO - Running post-action listener: _resource_record_post_action 23:22:48 INFO - ##### 23:22:48 INFO - ##### Finished populate-webroot step (success) 23:22:48 INFO - ##### 23:22:48 INFO - ##### 23:22:48 INFO - ##### Running create-virtualenv step. 23:22:48 INFO - ##### 23:22:48 INFO - Running pre-action listener: _resource_record_pre_action 23:22:48 INFO - Running main action method: create_virtualenv 23:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:22:48 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 23:22:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:22:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:49 INFO - Using real prefix '/usr' 23:22:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 23:22:51 INFO - Installing pip.................done. 23:22:51 INFO - Return code: 0 23:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:22:51 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 23:22:51 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 23:22:51 INFO - Using env: {'DISPLAY': ':0', 23:22:51 INFO - 'HOME': '/home/cltbld', 23:22:51 INFO - 'LANG': 'en_US.UTF-8', 23:22:51 INFO - 'LANGUAGE': 'en_US:en', 23:22:51 INFO - 'LOGNAME': 'cltbld', 23:22:51 INFO - 'MAIL': '/var/mail/cltbld', 23:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:51 INFO - 'MOZ_NO_REMOTE': '1', 23:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:51 INFO - 'NO_EM_RESTART': '1', 23:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:51 INFO - 'PWD': '/builds/slave/test', 23:22:51 INFO - 'SHELL': '/bin/bash', 23:22:51 INFO - 'SHLVL': '1', 23:22:51 INFO - 'TERM': 'linux', 23:22:51 INFO - 'TMOUT': '86400', 23:22:51 INFO - 'USER': 'cltbld', 23:22:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:51 INFO - '_': '/tools/buildbot/bin/python'} 23:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:51 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 23:22:51 INFO - Cleaning up... 23:22:51 INFO - Return code: 0 23:22:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:22:51 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 23:22:51 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 23:22:51 INFO - Using env: {'DISPLAY': ':0', 23:22:51 INFO - 'HOME': '/home/cltbld', 23:22:51 INFO - 'LANG': 'en_US.UTF-8', 23:22:51 INFO - 'LANGUAGE': 'en_US:en', 23:22:51 INFO - 'LOGNAME': 'cltbld', 23:22:51 INFO - 'MAIL': '/var/mail/cltbld', 23:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:51 INFO - 'MOZ_NO_REMOTE': '1', 23:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:51 INFO - 'NO_EM_RESTART': '1', 23:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:51 INFO - 'PWD': '/builds/slave/test', 23:22:51 INFO - 'SHELL': '/bin/bash', 23:22:51 INFO - 'SHLVL': '1', 23:22:51 INFO - 'TERM': 'linux', 23:22:51 INFO - 'TMOUT': '86400', 23:22:51 INFO - 'USER': 'cltbld', 23:22:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:51 INFO - '_': '/tools/buildbot/bin/python'} 23:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:52 INFO - Downloading/unpacking psutil>=3.1.1 23:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:54 INFO - Installing collected packages: psutil 23:22:54 INFO - Running setup.py install for psutil 23:22:54 INFO - building 'psutil._psutil_linux' extension 23:22:54 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 23:22:54 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 23:22:54 INFO - building 'psutil._psutil_posix' extension 23:22:54 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 23:22:54 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 23:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:54 INFO - Successfully installed psutil 23:22:54 INFO - Cleaning up... 23:22:54 INFO - Return code: 0 23:22:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:22:54 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')]} 23:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:54 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')]} 23:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:54 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:22:54 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 23:22:54 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 23:22:54 INFO - Using env: {'DISPLAY': ':0', 23:22:54 INFO - 'HOME': '/home/cltbld', 23:22:54 INFO - 'LANG': 'en_US.UTF-8', 23:22:54 INFO - 'LANGUAGE': 'en_US:en', 23:22:54 INFO - 'LOGNAME': 'cltbld', 23:22:54 INFO - 'MAIL': '/var/mail/cltbld', 23:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:54 INFO - 'MOZ_NO_REMOTE': '1', 23:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:54 INFO - 'NO_EM_RESTART': '1', 23:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:54 INFO - 'PWD': '/builds/slave/test', 23:22:54 INFO - 'SHELL': '/bin/bash', 23:22:54 INFO - 'SHLVL': '1', 23:22:54 INFO - 'TERM': 'linux', 23:22:54 INFO - 'TMOUT': '86400', 23:22:54 INFO - 'USER': 'cltbld', 23:22:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:54 INFO - '_': '/tools/buildbot/bin/python'} 23:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:22:54 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 23:22:54 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 23:22:54 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 23:22:54 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 23:22:54 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 23:22:54 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 23:22:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:22:56 INFO - Installing collected packages: mozsystemmonitor 23:22:56 INFO - Running setup.py install for mozsystemmonitor 23:22:56 INFO - Successfully installed mozsystemmonitor 23:22:56 INFO - Cleaning up... 23:22:56 INFO - Return code: 0 23:22:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:22:56 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')]} 23:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:56 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')]} 23:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:56 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:22:56 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 23:22:56 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 23:22:56 INFO - Using env: {'DISPLAY': ':0', 23:22:56 INFO - 'HOME': '/home/cltbld', 23:22:56 INFO - 'LANG': 'en_US.UTF-8', 23:22:56 INFO - 'LANGUAGE': 'en_US:en', 23:22:56 INFO - 'LOGNAME': 'cltbld', 23:22:56 INFO - 'MAIL': '/var/mail/cltbld', 23:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:56 INFO - 'MOZ_NO_REMOTE': '1', 23:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:56 INFO - 'NO_EM_RESTART': '1', 23:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:56 INFO - 'PWD': '/builds/slave/test', 23:22:56 INFO - 'SHELL': '/bin/bash', 23:22:56 INFO - 'SHLVL': '1', 23:22:56 INFO - 'TERM': 'linux', 23:22:56 INFO - 'TMOUT': '86400', 23:22:56 INFO - 'USER': 'cltbld', 23:22:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:56 INFO - '_': '/tools/buildbot/bin/python'} 23:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:57 INFO - Downloading/unpacking jsonschema==2.5.1 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:22:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 INFO - Downloading functools32-3.2.3-2.tar.gz 23:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:22:59 INFO - warning: no files found matching '*.txt' 23:22:59 INFO - no previously-included directories found matching 'build' 23:22:59 INFO - no previously-included directories found matching 'dist' 23:22:59 INFO - no previously-included directories found matching '.git*' 23:22:59 INFO - Installing collected packages: jsonschema, functools32 23:22:59 INFO - Running setup.py install for functools32 23:22:59 INFO - warning: no files found matching '*.txt' 23:22:59 INFO - no previously-included directories found matching 'build' 23:22:59 INFO - no previously-included directories found matching 'dist' 23:22:59 INFO - no previously-included directories found matching '.git*' 23:22:59 INFO - Successfully installed jsonschema functools32 23:22:59 INFO - Cleaning up... 23:22:59 INFO - Return code: 0 23:22:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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', '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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:22: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 blobuploader==1.2.4 23:22:59 INFO - Using env: {'DISPLAY': ':0', 23:22:59 INFO - 'HOME': '/home/cltbld', 23:22:59 INFO - 'LANG': 'en_US.UTF-8', 23:22:59 INFO - 'LANGUAGE': 'en_US:en', 23:22:59 INFO - 'LOGNAME': 'cltbld', 23:22:59 INFO - 'MAIL': '/var/mail/cltbld', 23:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:59 INFO - 'MOZ_NO_REMOTE': '1', 23:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:59 INFO - 'NO_EM_RESTART': '1', 23:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:59 INFO - 'PWD': '/builds/slave/test', 23:22:59 INFO - 'SHELL': '/bin/bash', 23:22:59 INFO - 'SHLVL': '1', 23:22:59 INFO - 'TERM': 'linux', 23:22:59 INFO - 'TMOUT': '86400', 23:22:59 INFO - 'USER': 'cltbld', 23:22:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:59 INFO - '_': '/tools/buildbot/bin/python'} 23:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:22:59 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 23:23:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:02 INFO - Downloading docopt-0.6.1.tar.gz 23:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:02 INFO - Running setup.py install for blobuploader 23:23:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:02 INFO - Running setup.py install for requests 23:23:02 INFO - Running setup.py install for docopt 23:23:02 INFO - Successfully installed blobuploader requests docopt 23:23:02 INFO - Cleaning up... 23:23:02 INFO - Return code: 0 23:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:02 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:23:02 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 23:23:02 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 23:23:02 INFO - Using env: {'DISPLAY': ':0', 23:23:02 INFO - 'HOME': '/home/cltbld', 23:23:02 INFO - 'LANG': 'en_US.UTF-8', 23:23:02 INFO - 'LANGUAGE': 'en_US:en', 23:23:02 INFO - 'LOGNAME': 'cltbld', 23:23:02 INFO - 'MAIL': '/var/mail/cltbld', 23:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:02 INFO - 'MOZ_NO_REMOTE': '1', 23:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:02 INFO - 'NO_EM_RESTART': '1', 23:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:02 INFO - 'PWD': '/builds/slave/test', 23:23:02 INFO - 'SHELL': '/bin/bash', 23:23:02 INFO - 'SHLVL': '1', 23:23:02 INFO - 'TERM': 'linux', 23:23:02 INFO - 'TMOUT': '86400', 23:23:02 INFO - 'USER': 'cltbld', 23:23:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:02 INFO - '_': '/tools/buildbot/bin/python'} 23:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:03 INFO - Running setup.py (path:/tmp/pip-SvWMQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:03 INFO - Running setup.py (path:/tmp/pip-nxIpnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:03 INFO - Running setup.py (path:/tmp/pip-BPGAw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:03 INFO - Running setup.py (path:/tmp/pip-PtkChl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:03 INFO - Running setup.py (path:/tmp/pip-wzRW2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:03 INFO - Running setup.py (path:/tmp/pip-oGrfJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:03 INFO - Running setup.py (path:/tmp/pip-puz40c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:03 INFO - Running setup.py (path:/tmp/pip-BbP42p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:03 INFO - Running setup.py (path:/tmp/pip-NeKMVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:03 INFO - Running setup.py (path:/tmp/pip-7zRDi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:03 INFO - Running setup.py (path:/tmp/pip-u8bV2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:03 INFO - Running setup.py (path:/tmp/pip-QLUxhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:04 INFO - Running setup.py (path:/tmp/pip-H7x5y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:04 INFO - Running setup.py (path:/tmp/pip-oV924f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:04 INFO - Running setup.py (path:/tmp/pip-j6WHDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:04 INFO - Running setup.py (path:/tmp/pip-81vXLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:04 INFO - Running setup.py (path:/tmp/pip-sNYxu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:04 INFO - Running setup.py install for manifestparser 23:23:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:04 INFO - Running setup.py install for mozcrash 23:23:04 INFO - Running setup.py install for mozdebug 23:23:04 INFO - Running setup.py install for mozdevice 23:23:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:04 INFO - Running setup.py install for mozfile 23:23:04 INFO - Running setup.py install for mozhttpd 23:23:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozinfo 23:23:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozInstall 23:23:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozleak 23:23:05 INFO - Running setup.py install for mozlog 23:23:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for moznetwork 23:23:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozprocess 23:23:05 INFO - Running setup.py install for mozprofile 23:23:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozrunner 23:23:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:05 INFO - Running setup.py install for mozscreenshot 23:23:05 INFO - Running setup.py install for moztest 23:23:06 INFO - Running setup.py install for mozversion 23:23:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:06 INFO - Cleaning up... 23:23:06 INFO - Return code: 0 23:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:06 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:23:06 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 23:23:06 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 23:23:06 INFO - Using env: {'DISPLAY': ':0', 23:23:06 INFO - 'HOME': '/home/cltbld', 23:23:06 INFO - 'LANG': 'en_US.UTF-8', 23:23:06 INFO - 'LANGUAGE': 'en_US:en', 23:23:06 INFO - 'LOGNAME': 'cltbld', 23:23:06 INFO - 'MAIL': '/var/mail/cltbld', 23:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:06 INFO - 'MOZ_NO_REMOTE': '1', 23:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:06 INFO - 'NO_EM_RESTART': '1', 23:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:06 INFO - 'PWD': '/builds/slave/test', 23:23:06 INFO - 'SHELL': '/bin/bash', 23:23:06 INFO - 'SHLVL': '1', 23:23:06 INFO - 'TERM': 'linux', 23:23:06 INFO - 'TMOUT': '86400', 23:23:06 INFO - 'USER': 'cltbld', 23:23:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:06 INFO - '_': '/tools/buildbot/bin/python'} 23:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:06 INFO - Running setup.py (path:/tmp/pip-9SCN0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:06 INFO - Running setup.py (path:/tmp/pip-2gZHDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:06 INFO - Running setup.py (path:/tmp/pip-A3GEg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:06 INFO - Running setup.py (path:/tmp/pip-emnGYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:06 INFO - Running setup.py (path:/tmp/pip-pGZ38Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:06 INFO - Running setup.py (path:/tmp/pip-DfYFpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:06 INFO - Running setup.py (path:/tmp/pip-m9sksu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:06 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)) 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:06 INFO - Running setup.py (path:/tmp/pip-Mrh6vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:07 INFO - Running setup.py (path:/tmp/pip-2t5i4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:07 INFO - Running setup.py (path:/tmp/pip-9RYaua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:07 INFO - Running setup.py (path:/tmp/pip-hLKNhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:07 INFO - Running setup.py (path:/tmp/pip-SP1m0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:07 INFO - Running setup.py (path:/tmp/pip-s5AyBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:07 INFO - Running setup.py (path:/tmp/pip-Gkjrpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:07 INFO - Running setup.py (path:/tmp/pip-mc8rwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:07 INFO - Running setup.py (path:/tmp/pip-9t1F5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:07 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)) 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:07 INFO - Running setup.py (path:/tmp/pip-Moskz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:07 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)) 23:23:07 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)) 23:23:07 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)) 23:23:07 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)) 23:23:07 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)) 23:23:07 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)) 23:23:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:09 INFO - Downloading blessings-1.6.tar.gz 23:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:09 INFO - Installing collected packages: blessings 23:23:09 INFO - Running setup.py install for blessings 23:23:09 INFO - Successfully installed blessings 23:23:09 INFO - Cleaning up... 23:23:09 INFO - Return code: 0 23:23:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:10 INFO - Reading from file tmpfile_stdout 23:23:10 INFO - Current package versions: 23:23:10 INFO - argparse == 1.2.1 23:23:10 INFO - blessings == 1.6 23:23:10 INFO - blobuploader == 1.2.4 23:23:10 INFO - docopt == 0.6.1 23:23:10 INFO - functools32 == 3.2.3-2 23:23:10 INFO - jsonschema == 2.5.1 23:23:10 INFO - manifestparser == 1.1 23:23:10 INFO - mozInstall == 1.12 23:23:10 INFO - mozcrash == 0.17 23:23:10 INFO - mozdebug == 0.1 23:23:10 INFO - mozdevice == 0.48 23:23:10 INFO - mozfile == 1.2 23:23:10 INFO - mozhttpd == 0.7 23:23:10 INFO - mozinfo == 0.9 23:23:10 INFO - mozleak == 0.1 23:23:10 INFO - mozlog == 3.2 23:23:10 INFO - moznetwork == 0.27 23:23:10 INFO - mozprocess == 0.23 23:23:10 INFO - mozprofile == 0.28 23:23:10 INFO - mozrunner == 6.12 23:23:10 INFO - mozscreenshot == 0.1 23:23:10 INFO - mozsystemmonitor == 0.3 23:23:10 INFO - moztest == 0.7 23:23:10 INFO - mozversion == 1.4 23:23:10 INFO - psutil == 3.1.1 23:23:10 INFO - requests == 1.2.3 23:23:10 INFO - wsgiref == 0.1.2 23:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:23:10 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 23:23:10 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 23:23:10 INFO - Using env: {'DISPLAY': ':0', 23:23:10 INFO - 'HOME': '/home/cltbld', 23:23:10 INFO - 'LANG': 'en_US.UTF-8', 23:23:10 INFO - 'LANGUAGE': 'en_US:en', 23:23:10 INFO - 'LOGNAME': 'cltbld', 23:23:10 INFO - 'MAIL': '/var/mail/cltbld', 23:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:10 INFO - 'MOZ_NO_REMOTE': '1', 23:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:10 INFO - 'NO_EM_RESTART': '1', 23:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:10 INFO - 'PWD': '/builds/slave/test', 23:23:10 INFO - 'SHELL': '/bin/bash', 23:23:10 INFO - 'SHLVL': '1', 23:23:10 INFO - 'TERM': 'linux', 23:23:10 INFO - 'TMOUT': '86400', 23:23:10 INFO - 'USER': 'cltbld', 23:23:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:10 INFO - '_': '/tools/buildbot/bin/python'} 23:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 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)) 23:23:10 INFO - Cleaning up... 23:23:10 INFO - Return code: 0 23:23:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:23:10 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 23:23:10 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 23:23:10 INFO - Using env: {'DISPLAY': ':0', 23:23:10 INFO - 'HOME': '/home/cltbld', 23:23:10 INFO - 'LANG': 'en_US.UTF-8', 23:23:10 INFO - 'LANGUAGE': 'en_US:en', 23:23:10 INFO - 'LOGNAME': 'cltbld', 23:23:10 INFO - 'MAIL': '/var/mail/cltbld', 23:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:10 INFO - 'MOZ_NO_REMOTE': '1', 23:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:10 INFO - 'NO_EM_RESTART': '1', 23:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:10 INFO - 'PWD': '/builds/slave/test', 23:23:10 INFO - 'SHELL': '/bin/bash', 23:23:10 INFO - 'SHLVL': '1', 23:23:10 INFO - 'TERM': 'linux', 23:23:10 INFO - 'TMOUT': '86400', 23:23:10 INFO - 'USER': 'cltbld', 23:23:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:10 INFO - '_': '/tools/buildbot/bin/python'} 23:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:23:10 INFO - Cleaning up... 23:23:10 INFO - Return code: 0 23:23:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 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 0x7fab67035f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a80450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, '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': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', '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 23:23:10 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 23:23:10 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 23:23:10 INFO - Using env: {'DISPLAY': ':0', 23:23:10 INFO - 'HOME': '/home/cltbld', 23:23:10 INFO - 'LANG': 'en_US.UTF-8', 23:23:10 INFO - 'LANGUAGE': 'en_US:en', 23:23:10 INFO - 'LOGNAME': 'cltbld', 23:23:10 INFO - 'MAIL': '/var/mail/cltbld', 23:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:10 INFO - 'MOZ_NO_REMOTE': '1', 23:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:10 INFO - 'NO_EM_RESTART': '1', 23:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:10 INFO - 'PWD': '/builds/slave/test', 23:23:10 INFO - 'SHELL': '/bin/bash', 23:23:10 INFO - 'SHLVL': '1', 23:23:10 INFO - 'TERM': 'linux', 23:23:10 INFO - 'TMOUT': '86400', 23:23:10 INFO - 'USER': 'cltbld', 23:23:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:10 INFO - '_': '/tools/buildbot/bin/python'} 23:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:10 INFO - Downloading/unpacking flake8 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:23:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:23:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:23:13 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 23:23:13 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 23:23:13 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 23:23:13 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 23:23:13 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 23:23:13 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 23:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:13 INFO - no previously-included directories found matching 'docs/_build' 23:23:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:23:13 INFO - Running setup.py install for pep8 23:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:13 INFO - no previously-included directories found matching 'docs/_build' 23:23:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:23:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:23:13 INFO - Cleaning up... 23:23:13 INFO - Return code: 0 23:23:13 INFO - Running post-action listener: _resource_record_post_action 23:23:13 INFO - Running post-action listener: _start_resource_monitoring 23:23:13 INFO - Starting resource monitoring. 23:23:13 INFO - ##### 23:23:13 INFO - ##### Finished create-virtualenv step (success) 23:23:13 INFO - ##### 23:23:13 INFO - ##### 23:23:13 INFO - ##### Running install step. 23:23:13 INFO - ##### 23:23:13 INFO - Running pre-action listener: _resource_record_pre_action 23:23:13 INFO - Running main action method: install 23:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:13 INFO - Reading from file tmpfile_stdout 23:23:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:23:13 INFO - Reading from file tmpfile_stdout 23:23:13 INFO - Output received: 23:23:13 INFO - Usage: mozinstall [options] installer 23:23:13 INFO - Options: 23:23:13 INFO - -h, --help show this help message and exit 23:23:13 INFO - -d DEST, --destination=DEST 23:23:13 INFO - Directory to install application into. [default: 23:23:13 INFO - "/builds/slave/test"] 23:23:13 INFO - --app=APP Application being installed. [default: firefox] 23:23:13 INFO - mkdir: /builds/slave/test/build/application 23:23:13 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'] 23:23:13 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 23:23:29 INFO - Reading from file tmpfile_stdout 23:23:29 INFO - Output received: 23:23:29 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:29 INFO - Running post-action listener: _resource_record_post_action 23:23:29 INFO - ##### 23:23:29 INFO - ##### Finished install step (success) 23:23:29 INFO - ##### 23:23:29 INFO - ##### 23:23:29 INFO - ##### Running run-tests step. 23:23:29 INFO - ##### 23:23:29 INFO - Running pre-action listener: _resource_record_pre_action 23:23:29 INFO - Running main action method: run_tests 23:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:29 INFO - Python 2.7.3 23:23:29 INFO - Return code: 0 23:23:29 INFO - grabbing minidump binary from tooltool 23:23: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')]} 23:23:29 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 0x2b0f2c0>, '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 0x2b101c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:29 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 23:23:29 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 23:23:29 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 23:23:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:29 INFO - Return code: 0 23:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:23:30 INFO - Return code: 0 23:23:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:23:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:23:30 INFO - Using env: {'DISPLAY': ':0', 23:23:30 INFO - 'HOME': '/home/cltbld', 23:23:30 INFO - 'LANG': 'en_US.UTF-8', 23:23:30 INFO - 'LANGUAGE': 'en_US:en', 23:23:30 INFO - 'LOGNAME': 'cltbld', 23:23:30 INFO - 'MAIL': '/var/mail/cltbld', 23:23:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:30 INFO - 'MOZ_NO_REMOTE': '1', 23:23:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:30 INFO - 'NO_EM_RESTART': '1', 23:23:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:30 INFO - 'PWD': '/builds/slave/test', 23:23:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:30 INFO - 'SHELL': '/bin/bash', 23:23:30 INFO - 'SHLVL': '1', 23:23:30 INFO - 'TERM': 'linux', 23:23:30 INFO - 'TMOUT': '86400', 23:23:30 INFO - 'USER': 'cltbld', 23:23:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377', 23:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:30 INFO - '_': '/tools/buildbot/bin/python'} 23:23:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:23:31 INFO - mozversion application_buildid: 20160713152443 23:23:31 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:23:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:31 INFO - mozversion application_name: Firefox 23:23:31 INFO - mozversion application_remotingname: firefox-dev 23:23:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:31 INFO - mozversion application_vendor: Mozilla 23:23:31 INFO - mozversion application_version: 49.0a2 23:23:31 INFO - mozversion platform_buildid: 20160713152443 23:23:31 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:31 INFO - mozversion platform_version: 49.0a2 23:23:31 INFO - using testdate: 1468477411 23:23:31 INFO - actual date: 1468477411 23:23:31 INFO - starting webserver on 'localhost:50064' 23:23:31 INFO - SUITE-START | Running 2 tests 23:23:31 INFO - TEST-START | dromaeo_css 23:23:31 INFO - operating with platform_type : linux_ 23:23:31 INFO - Initialising browser for dromaeo_css test... 23:23:31 INFO - TEST-INFO | started process 12895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdPK5_/profile http://localhost:50064/getInfo.html) 23:23:35 INFO - PROCESS | 12895 | __metrics Screen width/height:1600/1200 23:23:35 INFO - PROCESS | 12895 | colorDepth:24 23:23:35 INFO - PROCESS | 12895 | Browser inner width/height: 1024/697 23:23:35 INFO - PROCESS | 12895 | __metrics 23:23:36 ERROR - PROCESS | 12895 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:23:37 INFO - TEST-INFO | 12895: exit 0 23:23:37 INFO - Browser initialized. 23:23:37 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:37 INFO - TEST-INFO | started process 12983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdPK5_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:49 INFO - PROCESS | 12983 | RSS: Main: 145580032 23:23:49 INFO - PROCESS | 12983 | 23:24:40 INFO - PROCESS | 12983 | 1468477480511 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] 23:26:48 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50064/tests/dromaeo/cssquery-ext.html) 23:26:49 INFO - PROCESS | 12983 | RSS: Main: 255160320 23:26:49 INFO - PROCESS | 12983 | 23:29:51 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-ext.html (next: http://localhost:50064/tests/dromaeo/cssquery-jquery.html) 23:29:52 INFO - PROCESS | 12983 | RSS: Main: 231034880 23:29:52 INFO - PROCESS | 12983 | 23:32:54 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50064/tests/dromaeo/cssquery-mootools.html) 23:32:55 INFO - PROCESS | 12983 | RSS: Main: 224325632 23:32:55 INFO - PROCESS | 12983 | 23:35:56 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50064/tests/dromaeo/cssquery-prototype.html) 23:35:57 INFO - PROCESS | 12983 | RSS: Main: 221474816 23:35:57 INFO - PROCESS | 12983 | 23:39:00 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50064/tests/dromaeo/cssquery-yui.html) 23:39:00 INFO - PROCESS | 12983 | RSS: Main: 201080832 23:39:00 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | Cycle 1(1): loaded http://localhost:50064/tests/dromaeo/cssquery-yui.html (next: http://localhost:50064/tests/dromaeo/cssquery-dojo.html) 23:42:03 INFO - PROCESS | 12983 | RSS: Main: 259190784 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | __start_tp_report 23:42:03 INFO - PROCESS | 12983 | _x_x_mozilla_page_load 23:42:03 INFO - PROCESS | 12983 | _x_x_mozilla_page_load_details 23:42:03 INFO - PROCESS | 12983 | |i|pagename|runs| 23:42:03 INFO - PROCESS | 12983 | |0;dojo.html;3265.8203798791064;3270.1988012936827;3280.6391296957318;3306.553615261939;3321.0867011571813;5354.437784032679;5419.729013549321;5420.268263784388;5429.945700542993;5446.2919820423385;5392.649477783951;5423.566114710824;5438.428964958682;5452.509274165324;5455.236266922624;4819.108464933981;4900.289458028584;4922.114019476493;4959.057779021974;5013.172826483626;4818.229083346665;4947.901041979158;4983.078130545842;4983.07813054586;4987.127252730776;4924;4936.679115857458;4953.702777833323;4961;4966.329545511364;5036.597072234213;5038.924416133761;5051.87370315745;5056.216286475602;5081.898362032739;4842.249451335048;4875.926861097087;4904.215325547931;4950.727709975949;4981.875453113665;5263.078961181778;5277.076511610453;5279.260903473479;5299.019681358923;5341.092014357569;5648.209250704905;5742.7415766290615;5749.511291540224;5794.855128621818;5799.710014499258;5713.057345537981;5765.509931655814;5789.652620842763;5825.941740582624;5849.385814489502;5457.645253058538;5497.532709719639;5503.559715222773;5503.862403439946;5505.807296744595;5773.711314434261;5980.491658209101;5981.940180598225;5984.042553191469;5986.670733109634;5600.0759874620235;5627.212190293362;5654.095344744821;5707.571932105108;5729.541636669056;5774.48029677331;5781.219535362757;5781.682007489629;5809.477147056785;5811.4479124483105;5549.139883318092;5638.661680299195;5704;5705.74324155414;5734.254546908958;5706.28671416073;5778.855528611818;5789.131630255411;5797.275340582427;5822.446867547576;4480.820767169342;4484.349769283501;4485.842995495142;4489.7979590918485;4510.436195475566;3925.3326934420647;3945.270125026879;3993.66053885423;4014.1770936957855;4053.0677944073027;5504.889902201933;5529.557635389159;5535.778568857281;5537.501624853702;5542;5805.390434004369;5812.360640329561;5813.331466881363;5818.040023396177;5854.765809367577;5361.249425080492;5428.077226871442;5472.753726082256;5474.945250547523;5521.585881058937;4946.579540739078;4974.552290293891;4977.452480227172;4979.2033274676605;4996.2505624156665;5824.44667756554;5930.466258036798;6005.279366476051;6014.338422773491;6021.2473440819895;5708.286464191976;5736.082226843685;5769.451902069297;5819.854503637443;5823.621464604787;5965.433283838029;5972.462478376967;5980.19267398913;5981.102834574848;6051.969740151271;5529.281193444826;5616.915746263728;5713.771449141987;5725.541956643542;5733.541316694738;5753.223314852608;5826.242588463472;5828.970855145697;5835.153902684172;5870.324912635102;5594.300712410949;5662.207290979184;5664.49019588239;5664.915026274692;5668.659880407189;5472.699001554953;5521.503064724194;5535.501804837584;5631.662100273997;5645.463680950304;5554.166874968787;5555.527780138734;5555.666660000413;5564.610477266552;5580.023495888122;5615.943840561542;5659.122835960433;5670.858228544319;5676.4323567642905;5682.659040457585;5351.063563876228;5436.320459942507;5498.80754173602;5519.006578815852;5586.581006424453 23:42:03 INFO - PROCESS | 12983 | |1;ext.html;590.7194082810665;630.4294613374894;651.8272657745696;657.4543129202763;666.6300203387118;33538.329233415316;36681.633183668186;46156.76921615395;47334.52665473344;47701;49151.262731058974;49491.50508494914;49572;49631;49639.25541116886;9027.729168124966;9172.495512746797;9174.26605871532;9179.403338782991;9181.632734690604;8336.62485188165;10991.835122473129;11253.324800511995;11265.662030139109;11266.887331126707;10968.451577421138;11050.944745276262;11094.55621775128;11444.256123351997;11457.713557161054;8230.300424463927;8432.451890627151;11226.32642041476;11279.718007049889;11328.773424531504;10711.785764284748;11092.1126309895;11101.777964440747;11472.770544589144;11495.2528085675;45671;45679.31481027787;45844.312335314666;46144.07711845744;46265.768671156766;3555.8044307563073;3897.80510974453;3924.921501569981;3967.761934283952;4326.870193894189;34687;34824.12939676503;35173.648263517294;35622.10944726376;36481.81759091187;4684.156851766681;4736.407949006374;4771.355866957951;4792.233242681189;4919.557239848395;408498;410838;411773;412340;412655;71799.64100179466;72144;72442;72586.27413725901;72606;41317.79341103335;42167.57832421637;42189.57810421918;43874.341884871756;43926.560734392886;17459.738103928452;17604.823951760576;17671.646567068587;17683;17686.557836053944;12612;12833.743325133444;13037.804432933513;13050.216986980811;13156.342182890818;22419.55160896773;22461.213857514907;22519;22696.43258918507;22714.09143634236;8052.879206811903;8084.919150808534;8138.796530086677;8153.510789352657;8246.340292776684;1024.2011231239644;1095.8684957805115;1106.1206340958956;1109.8557187565564;1188.013948422807;33733.83133084319;33782;34265.828670856485;34392.14019649529;34592.654073459445;1032.948352582368;1203.9217450865665;1214.5324050240722;1227.8772122787827;1267.8161666558483;17306.740398894028;17522.912385438245;17645.205965731573;17950.281988720304;18037.7294340585;554590;555447;555691;557360;557536;64385.67807160934;66045;66076.66961665257;66124.6693766528;66135.66932165404;1358.7486315031751;1412.6468382904275;1459.8832093432713;1465.6116129225763;1471.808664873581;34321.313573727886;35359.64640353563;35589.1102722434;36092.819535902156;36238.4564231542;54352.72823635856;55269;55283.72358138183;55360.72319638376;55451.72274138604;412347;421680;422311;422634;424161;27570.17289481319;28328.291792705346;28346.433071338044;29907.401851962404;30906.845465773426;47189;52786.472135278156;52905.47094529006;53230.4676953241;53271.46728532665;42819.5718042828;43423.56576434321;43625.78187109171;44083.77958110189;45001.54998450105;40950.60725536341;44984.32523512215;45379.092418150794;45410.77294613506;46526.53473465222;43459;43986.34020489759;44516.33225501555;45099;45255;38256;39142.412863806494;39207.80396098001;39385.606143938196;39408.40887386634;29363.85318073396;29420.85289573624;29465.084769489913;29582.852085739432;30047.549286760277 23:42:03 INFO - PROCESS | 12983 | |2;jquery.html;422.80973561897156;427.2523084601947;427.5553424438584;431.49515067371175;436.8602047344849;18489.630207395843;19779.307724229653;20412.183512659496;20711.689324660143;20743.896280518613;17336.306547738077;17402.47792566222;17582.384616538424;17638.559036024075;17854.196561154746;5581.776728930838;5710.371859095496;5815.098659707731;5827.825165245049;5830;4112;5665.348484924245;5711.428857114297;6042.607230530023;6363.0773537836985;6460.127882735817;6484.221893372778;6489.383508566679;6490.643014634217;6499.057636642684;6358.141650877119;6424.967875160618;6518.120053792724;6527.575707579016;6533.673316334188;3806.3909774435956;5475.315585551806;5773.566982476331;5783.363829978699;5791.739371728282;23573.528529429488;23914.521709565885;24012.399690007715;24061.759382406126;24140.758592414026;2455.5211733711935;2556.987215063931;2871.497487939623;2942.279141610319;3058.2660161561066;14695.26523673812;14765.557033289018;14913.627159320995;15010.699786004328;15143.242837858063;2039.734834471524;2079.3450063230034;2132.402927180392;2153.06341741343;2199.538096999632;56250.43749562493;81771;86157.56921215354;86185;87942;10494.580216791242;10504.947475262576;11025.669229923114;11274.943625281821;11622;14926.328315225841;15082.849171508144;15088.094714317176;15089.47186848455;15092.698146037017;8358.665653373797;8397.622107005078;8461.576921153917;8682.6526938923;8694.521801300989;8580.613872375758;8611.61247743853;8638.740837774876;8686.305095592465;8780.956095219482;6847.417969472651;7058;7123.89314160288;7126.714931402789;7128.251533589002;1756.1264105768194;1947.766268047815;1978.2383782243653;2096.433962830027;2097.4022403614895;979.2215188924822;1104.2215238257008;1115.9497822598003;1116.0680831505622;1160.8897154770284;19298.4210473686;19535;19776;19819.504512387306;20004.099815508336;1082.5345101606385;1119.2445099557765;1127.7800828838463;1130.3613458396144;1148.2593727046008;11256.15578831591;11393.772124557463;11449.370284634258;11513.251638643462;11544.595939142258;506185;508126;511988;513944;518931;88534;91774;91780;106730.46634766777;107251;1066.8719753629614;1067.4716015572342;1112.7551938573502;1114.1810769084716;1121.4897221764077;14295.928520357747;16686;17203.225854836313;17700.380486682905;17716.114194289978;40027.79986100051;41861;41931.37102943519;41931.7903410481;43009.56990430181;57867.71066144642;59036.70481647564;59368.70315648394;59708;60259.69870150621;8966.68616598416;9048.773780655536;9054.777605023237;9333.53332333367;9380;13230.206187628773;13673.31633418345;13766;13902.374393152535;13929;12001.579944701894;12038.157328987238;12067.155299128977;12138.211016283913;12150.270983741004;11711.180217385043;11838.28970261787;11883.881161188277;11982.760344793229;12131.696707582381;11848.229865058744;12316.938415307866;12409.93795031019;12586.559470418491;12612.684682883002;8002.9599852000365;8328.541930193898;8568.614412351335;9040.095990400907;9305.162535371848;11907.82138267944;12545.247285162919;12725.236485810881;12828.294443805307;12836.871631283568 23:42:03 INFO - PROCESS | 12983 | |3;mootools.html;1432.1550285331653;1584.0812328849267;1604.5026041927003;1786.794518630358;1914.684077127275;9198.44809311441;9556.99999999999;9559.091886270802;9844.261680373966;9861.161801246884;9527.857082143755;9745.31782775206;9760.85358719618;9795.363301385423;9797.902020979787;2201.218567408563;2266;2268.523610041885;2534.581794003987;2558.7441255874355;2446.987765061172;2529.178017144426;2534.8986040558357;2536.4800215955684;2537.835040722347;2516.6225066240027;2522.8360156589856;2534.721180670125;2535.1253817432957;2549.987250063747;2187.73747150343;2261.9660705089436;2528.8356256843244;2561.3852675357966;2563.384787650969;2233.966490502644;2360.1857359211044;2423;2423;2432.9391765205833;9267.860982085274;9285.628574856997;9316.813663726754;9332.953335233347;9336.579853906522;5383.623146379755;5503.036968530531;5504.944950550484;5515.641483303572;5516.641418307797;3680.5583330000304;3798.0694729791103;3808.314503389389;3843.250566139604;3853.7495062820826;1243.4031664800946;1281.9038572107129;1283.159530507519;1286.871312868715;1291.2252648410972;13146.737065258641;13156.802647960289;13161.802572961413;13221.86778132216;13226.470941162343;4986.925196122061;4992.2761199626575;5085.186370180827;5185.196294574347;5203.334932821536;11097.667069987914;11105.444727763579;11119.054880335101;11123.833142502868;11145.16411269158;5523.944760552424;5571.4428557143965;5583.972080139573;5586.86032849182;5587.217789509472;4414.735115893057;4589.770511474413;4973.1297023020825;5010.749462526859;5033.370828646419;4422.911541769211;4432.534583868712;4443.955560444354;4477.70894891831;4542.341360502709;1386.6671998720235;1387.1053170704838;1394.5816255123625;1404.6769243073945;1414.2292450614234;913.2009491694768;1001.4942454060798;1004.2568499310457;1086.5708045322053;1089.2593036735095;6622.357703263186;6770.32296770319;6798.388145066968;6805.523613347018;6812.114425124702;476.5568021739815;479.7361451201825;487.8536439068265;505.7471264367816;511.0162936347516;4692.741899195509;4719.032598317337;4723.267893476516;4723.551262630044;4749.691270067435;12018.338991355384;12366.134370593973;12376.443060062138;12399.25604463735;12425;12094;12146.695391625224;12176.756464870654;12385.504579816887;12390.194637348544;9078.818423631623;9122.179003889682;9123.452592844318;9204.539773011322;9327.300452466228;6727.697253623696;6802.3537763912345;6823.55646882951;6842.726290948505;6905.965470172617;11009.83485247738;11069.778604428027;11364.829527556927;11376.886231137583;11473.13951453661;11457.140714446283;11574.942125289319;11578.94210528942;11587.478563464496;11690.47392867306;7643.88534171999;7704.537727736354;8604.354673399645;8758.430702004349;8798.47209167452;9548.474833884204;9632.325737198329;9646.131848133702;9697.369670971364;9721.368111072758;8487.278581320657;8657.437266577652;8699.217070463688;8719.128087191484;8799.780005499657;8225.753227403187;8271.875921861298;8460.53467059293;8486.575671216538;8501.787455313666;7928.08826984881;8000.679972801023;8008.879866801886;8009.679612815422;8016.7194148204535;5760.423957604206;5857.502112320501;5897.3807750185615;5944.970275148769;5995.340512543529;5801.448862358069;5802.100674395476;5819.679917604572;5908;5942.257217847769 23:42:03 INFO - PROCESS | 12983 | |4;prototype.html;352.69844283137917;361.4181168319006;365.2275437449793;365.674549650811;367.28746232309317;5415.620906536539;5419.566434685225;5445.264889239947;5450.509454149126;5467.535259502942;5101.413337466192;5201.191356667405;5222.4255331913455;5248.580113590913;5400.135978243482;4159.459270294872;4163.354680024593;4276.486821581399;4280.743155410685;4314.266574682296;4217.1987322408795;4246.893827654302;4252.744835309876;4265.87202383929;4270.67969902257;4146.771927543984;4219.810108545123;4240.897366684669;4241.851535196269;4275.636570891478;4019.919601607981;4128.545859955402;4229.873103806891;4244.851430199959;4244.915101697949;3787.6401741834484;3788.488554045196;3799.202167544819;3815.618438156162;3819.3698039823394;5174.353205849269;5195.870103247411;5209.505097015777;5212.765425555821;5238.502342277516;4658.697184683018;4754.643401744883;4761.119192949315;4822.614190864722;4947.92578111325;5457.608309880995;5518.33779946405;5538.889222215533;5581.66040150365;5588.077967135418;4099.733517321364;4102.651274641659;4117.958820411787;4135.17296540693;4144.3990621359735;5614.410486898858;5803.026970829896;5815.680137592431;5830.416958304136;5884.293884733816;4273.294906340419;4274.5939135782055;4275.764832934218;4304.870853874389;4308.246056940023;4332.610065094157;4340.110277393127;4342.392065110887;4346.326319420432;4360.672949528798;4637.791299391535;4805.519448055236;4827.831025914146;4898.975505122452;4909.214525675875;5596.496315331639;5636.718164091779;5649.180868774005;5650.208970744099;5655.830325090254;1454.2510607037384;1466.8631810346853;1472.5140703567797;1474.4176050460223;1476.0995792566525;935.6351023100996;959.3332633819429;966.1353088985319;967.8403063494444;980.9607615695435;4909.772556860785;4933.728644924492;4973.378327709036;4977.278294647256;5008.449070602303;5194.6104042196985;5196.480351964773;5224.634275600747;5261.184516399964;5270.393904701008;5018.849434516897;5031.723255220924;5268.733385301138;5367.329083864517;5431.67409955396;3054.801437906529;3071.508558630608;3073.431415188197;3081;3092.768042396829;5854.385289544536;6072.726727297282;6081.148639190517;6085.482733967574;6090.482309003784;5909.527237820964;5922.615030023035;5937.70311484424;5940.613860099166;5944.85137871548;6028.638281703112;6082.783443311356;6101.725422356093;6105.664188469588;6107.267127944586;5576.33084029919;5788.710564471676;5797.159411885337;5807.796727114531;5812.505936995402;5738.741756620879;5743.4543718346695;5752.482276595127;5754.53963682896;5755.5971082025535;5894.616849904743;6009.95661475083;6089.2997305310455;6101.511879049576;6111.7249723763425;4176.498820141603;4198.433211516406;4201.13876655291;4204;4206.411102445599;5755.985405108178;5780.595358325045;5837.124431335334;5883.852903677443;5905.379935106924;5498.917516237339;5688.54491640676;5696.259486266758;5784.652920824764;5785.681787501728;5577.916331255115;5583.609147359646;5617.43825617435;5660.830175094754;5667.316244440982;5559.555235581063;5618.550515958632;5632.690202038763;5647.463490968352;5671.234383358194;5468.535174510212;5691.089425691869;5692.260006199168;5700.261420266858;5706.8586282744445;5506.779728810803;5527.53015993645;5552.639078459887;5562.554995600423;5580.274564306615 23:42:03 INFO - PROCESS | 12983 | |5;yui.html;853.8335024670192;857.4812238595649;864.2351518905771;891.5586784541653;895.9238464730502;15482.458113966013;16895.32418703252;17274.049927253996;17315;17348.82651173488;15160.696786064273;15480.69038619227;15548.689026219468;15549.222538873068;15575.37698492059;721.6391804097951;839.8026463781038;859.7893516088567;869.5521806269776;872.9825403491926;855.5551113421018;855.7732200966749;857.3826844671827;858.0347109501811;858.0861382627513;918.6004088221612;919.6827094652334;920.4707293306342;920.8158368326361;921.1341339141219;749.3068911257066;878.6265837019241;897.228383590112;897.6050537763364;906.5331354352513;664.4817042706649;667.4326822201139;667.6094484726441;667.9699413526403;668.6589839182003;14354.92822535891;14381.424743010268;14389.13665180082;14443.566692999228;14491.637709057359;14804.333804978802;14995.100293982287;15200.315985780666;15238.314275857612;15497.45758898433;12510.81233781494;12584.622461326175;12618.116731828775;13872.722545549033;14121.576352709435;4748.501407352247;4794.280857871312;4794.976025119887;4858.5384388483035;4862.5380588844;77079;77319.6134019332;77324.61337693276;80246;80700.19299806985;12308.630741077783;12322.373712799037;12517.248965062125;12558.560450384375;12709;21609.135634574755;21658.02538885754;21673.566528669337;21776;21778.564428711335;8912.376133670581;8951.32865035125;9033.096690330914;9098.590563424661;9251.953740231256;5050.217216331401;5093.592512599057;5107.61692873036;5150.845474635767;5188.662736922088;3776.4901738264984;4170.70805043644;4350.8042138103865;4353.825846966086;4359.346098085249;593.6289818863211;709;715.5492040014757;717.5156769180886;728.3372131360543;633.7280848159309;636.7039326713101;764.9349805266614;774.8798936164903;789.8933643957993;10384.584616615251;10679.51942162589;10679.57281708723;10765.677029688964;10785.083267922157;569.0984490830036;694.6283738200038;709.5387997801367;762.1806557950225;802.4904185842032;4773.498782627774;4823.057934659854;4908.975455122773;5029.748512574357;5051.797928082836;123740;123789.38105309416;123801;125205.37397312955;130041.34979325043;105703;105855;106485.46757266164;107564;109188;76654.616726916;77845;78821.60589197018;86361.13638863657;89009.55495222482;10639.574417023232;10771.299865508718;10799;10914.345139291669;11077.11383089367;49193;50001.49998499968;53506;55109.1733624004;56192;74856;77892;79041;79953.2004679969;80449;13353.599392018255;13809.309534523434;13991.720165596835;14099.295035247991;14102.929485352508;15256.694866102394;15285.77071343953;15711.68576628484;16041.679166416372;16219.35122595083;12547.623571292876;12651.620451386472;13244.27156506363;14235.50175743844;14377.56867293983;15007.324670390077;15084.773728394302;15104.622384440478;15610.609734756721;15699;14429.567112986628;14613;14640.780388293972;14912.850871491146;15169.393224271347;11793.29240245588;12219.75560488803;12321.383930803604;12395.75208495807;12758.106932514635;12391.132620716824;12771.361431928552;12828.486860525474;12991;13026.47894084226 23:42:03 INFO - PROCESS | 12983 | __end_tp_report 23:42:03 INFO - PROCESS | 12983 | __start_cc_report 23:42:03 INFO - PROCESS | 12983 | _x_x_mozilla_cycle_collect,904 23:42:03 INFO - PROCESS | 12983 | __end_cc_report 23:42:03 INFO - PROCESS | 12983 | __startTimestamp1468478523479__endTimestamp 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | ------- Summary: start ------- 23:42:03 INFO - PROCESS | 12983 | Number of tests: 6 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#0] dojo.html Cycles:165 Average:5377.35 Median:5542.00 stddev:578.40 (10.4%) stddev-sans-first:555.95 23:42:03 INFO - PROCESS | 12983 | Values: 3265.8 3270.2 3280.6 3306.6 3321.1 5354.4 5419.7 5420.3 5429.9 5446.3 5392.6 5423.6 5438.4 5452.5 5455.2 4819.1 4900.3 4922.1 4959.1 5013.2 4818.2 4947.9 4983.1 4983.1 4987.1 4924.0 4936.7 4953.7 4961.0 4966.3 5036.6 5038.9 5051.9 5056.2 5081.9 4842.2 4875.9 4904.2 4950.7 4981.9 5263.1 5277.1 5279.3 5299.0 5341.1 5648.2 5742.7 5749.5 5794.9 5799.7 5713.1 5765.5 5789.7 5825.9 5849.4 5457.6 5497.5 5503.6 5503.9 5505.8 5773.7 5980.5 5981.9 5984.0 5986.7 5600.1 5627.2 5654.1 5707.6 5729.5 5774.5 5781.2 5781.7 5809.5 5811.4 5549.1 5638.7 5704.0 5705.7 5734.3 5706.3 5778.9 5789.1 5797.3 5822.4 4480.8 4484.3 4485.8 4489.8 4510.4 3925.3 3945.3 3993.7 4014.2 4053.1 5504.9 5529.6 5535.8 5537.5 5542.0 5805.4 5812.4 5813.3 5818.0 5854.8 5361.2 5428.1 5472.8 5474.9 5521.6 4946.6 4974.6 4977.5 4979.2 4996.3 5824.4 5930.5 6005.3 6014.3 6021.2 5708.3 5736.1 5769.5 5819.9 5823.6 5965.4 5972.5 5980.2 5981.1 6052.0 5529.3 5616.9 5713.8 5725.5 5733.5 5753.2 5826.2 5829.0 5835.2 5870.3 5594.3 5662.2 5664.5 5664.9 5668.7 5472.7 5521.5 5535.5 5631.7 5645.5 5554.2 5555.5 5555.7 5564.6 5580.0 5615.9 5659.1 5670.9 5676.4 5682.7 5351.1 5436.3 5498.8 5519.0 5586.6 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#1] ext.html Cycles:180 Average:63703.88 Median:411305.50 stddev:123666.97 (30.1%) stddev-sans-first:123923.11 23:42:03 INFO - PROCESS | 12983 | Values: 590.7 630.4 651.8 657.5 666.6 33538.3 36681.6 46156.8 47334.5 47701.0 49151.3 49491.5 49572.0 49631.0 49639.3 9027.7 9172.5 9174.3 9179.4 9181.6 8336.6 10991.8 11253.3 11265.7 11266.9 10968.5 11050.9 11094.6 11444.3 11457.7 8230.3 8432.5 11226.3 11279.7 11328.8 10711.8 11092.1 11101.8 11472.8 11495.3 45671.0 45679.3 45844.3 46144.1 46265.8 3555.8 3897.8 3924.9 3967.8 4326.9 34687.0 34824.1 35173.6 35622.1 36481.8 4684.2 4736.4 4771.4 4792.2 4919.6 408498.0 410838.0 411773.0 412340.0 412655.0 71799.6 72144.0 72442.0 72586.3 72606.0 41317.8 42167.6 42189.6 43874.3 43926.6 17459.7 17604.8 17671.6 17683.0 17686.6 12612.0 12833.7 13037.8 13050.2 13156.3 22419.6 22461.2 22519.0 22696.4 22714.1 8052.9 8084.9 8138.8 8153.5 8246.3 1024.2 1095.9 1106.1 1109.9 1188.0 33733.8 33782.0 34265.8 34392.1 34592.7 1032.9 1203.9 1214.5 1227.9 1267.8 17306.7 17522.9 17645.2 17950.3 18037.7 554590.0 555447.0 555691.0 557360.0 557536.0 64385.7 66045.0 66076.7 66124.7 66135.7 1358.7 1412.6 1459.9 1465.6 1471.8 34321.3 35359.6 35589.1 36092.8 36238.5 54352.7 55269.0 55283.7 55360.7 55451.7 412347.0 421680.0 422311.0 422634.0 424161.0 27570.2 28328.3 28346.4 29907.4 30906.8 47189.0 52786.5 52905.5 53230.5 53271.5 42819.6 43423.6 43625.8 44083.8 45001.5 40950.6 44984.3 45379.1 45410.8 46526.5 43459.0 43986.3 44516.3 45099.0 45255.0 38256.0 39142.4 39207.8 39385.6 39408.4 29363.9 29420.9 29465.1 29582.9 30047.5 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#2] jquery.html Cycles:180 Average:30136.39 Median:12886.53 stddev:84322.93 (654.3%) stddev-sans-first:84529.96 23:42:03 INFO - PROCESS | 12983 | Values: 422.8 427.3 427.6 431.5 436.9 18489.6 19779.3 20412.2 20711.7 20743.9 17336.3 17402.5 17582.4 17638.6 17854.2 5581.8 5710.4 5815.1 5827.8 5830.0 4112.0 5665.3 5711.4 6042.6 6363.1 6460.1 6484.2 6489.4 6490.6 6499.1 6358.1 6425.0 6518.1 6527.6 6533.7 3806.4 5475.3 5773.6 5783.4 5791.7 23573.5 23914.5 24012.4 24061.8 24140.8 2455.5 2557.0 2871.5 2942.3 3058.3 14695.3 14765.6 14913.6 15010.7 15143.2 2039.7 2079.3 2132.4 2153.1 2199.5 56250.4 81771.0 86157.6 86185.0 87942.0 10494.6 10504.9 11025.7 11274.9 11622.0 14926.3 15082.8 15088.1 15089.5 15092.7 8358.7 8397.6 8461.6 8682.7 8694.5 8580.6 8611.6 8638.7 8686.3 8781.0 6847.4 7058.0 7123.9 7126.7 7128.3 1756.1 1947.8 1978.2 2096.4 2097.4 979.2 1104.2 1115.9 1116.1 1160.9 19298.4 19535.0 19776.0 19819.5 20004.1 1082.5 1119.2 1127.8 1130.4 1148.3 11256.2 11393.8 11449.4 11513.3 11544.6 506185.0 508126.0 511988.0 513944.0 518931.0 88534.0 91774.0 91780.0 106730.5 107251.0 1066.9 1067.5 1112.8 1114.2 1121.5 14295.9 16686.0 17203.2 17700.4 17716.1 40027.8 41861.0 41931.4 41931.8 43009.6 57867.7 59036.7 59368.7 59708.0 60259.7 8966.7 9048.8 9054.8 9333.5 9380.0 13230.2 13673.3 13766.0 13902.4 13929.0 12001.6 12038.2 12067.2 12138.2 12150.3 11711.2 11838.3 11883.9 11982.8 12131.7 11848.2 12316.9 12409.9 12586.6 12612.7 8003.0 8328.5 8568.6 9040.1 9305.2 11907.8 12545.2 12725.2 12828.3 12836.9 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#3] mootools.html Cycles:180 Average:6384.14 Median:2613.12 stddev:3690.58 (141.2%) stddev-sans-first:3682.16 23:42:03 INFO - PROCESS | 12983 | Values: 1432.2 1584.1 1604.5 1786.8 1914.7 9198.4 9557.0 9559.1 9844.3 9861.2 9527.9 9745.3 9760.9 9795.4 9797.9 2201.2 2266.0 2268.5 2534.6 2558.7 2447.0 2529.2 2534.9 2536.5 2537.8 2516.6 2522.8 2534.7 2535.1 2550.0 2187.7 2262.0 2528.8 2561.4 2563.4 2234.0 2360.2 2423.0 2423.0 2432.9 9267.9 9285.6 9316.8 9333.0 9336.6 5383.6 5503.0 5504.9 5515.6 5516.6 3680.6 3798.1 3808.3 3843.3 3853.7 1243.4 1281.9 1283.2 1286.9 1291.2 13146.7 13156.8 13161.8 13221.9 13226.5 4986.9 4992.3 5085.2 5185.2 5203.3 11097.7 11105.4 11119.1 11123.8 11145.2 5523.9 5571.4 5584.0 5586.9 5587.2 4414.7 4589.8 4973.1 5010.7 5033.4 4422.9 4432.5 4444.0 4477.7 4542.3 1386.7 1387.1 1394.6 1404.7 1414.2 913.2 1001.5 1004.3 1086.6 1089.3 6622.4 6770.3 6798.4 6805.5 6812.1 476.6 479.7 487.9 505.7 511.0 4692.7 4719.0 4723.3 4723.6 4749.7 12018.3 12366.1 12376.4 12399.3 12425.0 12094.0 12146.7 12176.8 12385.5 12390.2 9078.8 9122.2 9123.5 9204.5 9327.3 6727.7 6802.4 6823.6 6842.7 6906.0 11009.8 11069.8 11364.8 11376.9 11473.1 11457.1 11574.9 11578.9 11587.5 11690.5 7643.9 7704.5 8604.4 8758.4 8798.5 9548.5 9632.3 9646.1 9697.4 9721.4 8487.3 8657.4 8699.2 8719.1 8799.8 8225.8 8271.9 8460.5 8486.6 8501.8 7928.1 8000.7 8008.9 8009.7 8016.7 5760.4 5857.5 5897.4 5945.0 5995.3 5801.4 5802.1 5819.7 5908.0 5942.3 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#4] prototype.html Cycles:180 Average:4748.31 Median:5269.56 stddev:1376.80 (26.1%) stddev-sans-first:1340.54 23:42:03 INFO - PROCESS | 12983 | Values: 352.7 361.4 365.2 365.7 367.3 5415.6 5419.6 5445.3 5450.5 5467.5 5101.4 5201.2 5222.4 5248.6 5400.1 4159.5 4163.4 4276.5 4280.7 4314.3 4217.2 4246.9 4252.7 4265.9 4270.7 4146.8 4219.8 4240.9 4241.9 4275.6 4019.9 4128.5 4229.9 4244.9 4244.9 3787.6 3788.5 3799.2 3815.6 3819.4 5174.4 5195.9 5209.5 5212.8 5238.5 4658.7 4754.6 4761.1 4822.6 4947.9 5457.6 5518.3 5538.9 5581.7 5588.1 4099.7 4102.7 4118.0 4135.2 4144.4 5614.4 5803.0 5815.7 5830.4 5884.3 4273.3 4274.6 4275.8 4304.9 4308.2 4332.6 4340.1 4342.4 4346.3 4360.7 4637.8 4805.5 4827.8 4899.0 4909.2 5596.5 5636.7 5649.2 5650.2 5655.8 1454.3 1466.9 1472.5 1474.4 1476.1 935.6 959.3 966.1 967.8 981.0 4909.8 4933.7 4973.4 4977.3 5008.4 5194.6 5196.5 5224.6 5261.2 5270.4 5018.8 5031.7 5268.7 5367.3 5431.7 3054.8 3071.5 3073.4 3081.0 3092.8 5854.4 6072.7 6081.1 6085.5 6090.5 5909.5 5922.6 5937.7 5940.6 5944.9 6028.6 6082.8 6101.7 6105.7 6107.3 5576.3 5788.7 5797.2 5807.8 5812.5 5738.7 5743.5 5752.5 5754.5 5755.6 5894.6 6010.0 6089.3 6101.5 6111.7 4176.5 4198.4 4201.1 4204.0 4206.4 5756.0 5780.6 5837.1 5883.9 5905.4 5498.9 5688.5 5696.3 5784.7 5785.7 5577.9 5583.6 5617.4 5660.8 5667.3 5559.6 5618.6 5632.7 5647.5 5671.2 5468.5 5691.1 5692.3 5700.3 5706.9 5506.8 5527.5 5552.6 5562.6 5580.3 23:42:03 INFO - PROCESS | 12983 | 23:42:03 INFO - PROCESS | 12983 | [#5] yui.html Cycles:180 Average:21885.23 Median:3973.60 stddev:31399.04 (790.2%) stddev-sans-first:31447.41 23:42:03 INFO - PROCESS | 12983 | Values: 853.8 857.5 864.2 891.6 895.9 15482.5 16895.3 17274.0 17315.0 17348.8 15160.7 15480.7 15548.7 15549.2 15575.4 721.6 839.8 859.8 869.6 873.0 855.6 855.8 857.4 858.0 858.1 918.6 919.7 920.5 920.8 921.1 749.3 878.6 897.2 897.6 906.5 664.5 667.4 667.6 668.0 668.7 14354.9 14381.4 14389.1 14443.6 14491.6 14804.3 14995.1 15200.3 15238.3 15497.5 12510.8 12584.6 12618.1 13872.7 14121.6 4748.5 4794.3 4795.0 4858.5 4862.5 77079.0 77319.6 77324.6 80246.0 80700.2 12308.6 12322.4 12517.2 12558.6 12709.0 21609.1 21658.0 21673.6 21776.0 21778.6 8912.4 8951.3 9033.1 9098.6 9252.0 5050.2 5093.6 5107.6 5150.8 5188.7 3776.5 4170.7 4350.8 4353.8 4359.3 593.6 709.0 715.5 717.5 728.3 633.7 636.7 764.9 774.9 789.9 10384.6 10679.5 10679.6 10765.7 10785.1 569.1 694.6 709.5 762.2 802.5 4773.5 4823.1 4909.0 5029.7 5051.8 123740.0 123789.4 123801.0 125205.4 130041.3 105703.0 105855.0 106485.5 107564.0 109188.0 76654.6 77845.0 78821.6 86361.1 89009.6 10639.6 10771.3 10799.0 10914.3 11077.1 49193.0 50001.5 53506.0 55109.2 56192.0 74856.0 77892.0 79041.0 79953.2 80449.0 13353.6 13809.3 13991.7 14099.3 14102.9 15256.7 15285.8 15711.7 16041.7 16219.4 12547.6 12651.6 13244.3 14235.5 14377.6 15007.3 15084.8 15104.6 15610.6 15699.0 14429.6 14613.0 14640.8 14912.9 15169.4 11793.3 12219.8 12321.4 12395.8 12758.1 12391.1 12771.4 12828.5 12991.0 13026.5 23:42:03 INFO - PROCESS | 12983 | -------- Summary: end -------- 23:42:03 INFO - PROCESS | 12983 | 23:42:04 INFO - TEST-INFO | 12983: exit 0 23:42:04 INFO - TEST-OK | dromaeo_css | took 1113088ms 23:42:04 INFO - TEST-START | kraken 23:42:04 INFO - operating with platform_type : linux_ 23:42:04 INFO - Initialising browser for kraken test... 23:42:04 INFO - TEST-INFO | started process 13170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CWorg/profile http://localhost:50064/getInfo.html) 23:42:08 INFO - PROCESS | 13170 | __metrics Screen width/height:1600/1200 23:42:08 INFO - PROCESS | 13170 | colorDepth:24 23:42:08 INFO - PROCESS | 13170 | Browser inner width/height: 1024/697 23:42:08 INFO - PROCESS | 13170 | __metrics 23:42:09 ERROR - PROCESS | 13170 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:42:10 INFO - TEST-INFO | 13170: exit 0 23:42:10 INFO - Browser initialized. 23:42:10 INFO - Running cycle 1/1 for kraken test... 23:42:10 INFO - TEST-INFO | started process 13262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CWorg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:21 INFO - PROCESS | 13262 | RSS: Main: 145305600 23:42:21 INFO - PROCESS | 13262 | 23:42:24 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:25 INFO - PROCESS | 13262 | RSS: Main: 194535424 23:42:25 INFO - PROCESS | 13262 | 23:42:27 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-dft) 23:42:28 INFO - PROCESS | 13262 | RSS: Main: 193277952 23:42:28 INFO - PROCESS | 13262 | 23:42:31 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-fft) 23:42:31 INFO - PROCESS | 13262 | RSS: Main: 279044096 23:42:31 INFO - PROCESS | 13262 | 23:42:33 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50064/tests/kraken/driver.html?testName=audio-oscillator) 23:42:34 INFO - PROCESS | 13262 | RSS: Main: 187228160 23:42:34 INFO - PROCESS | 13262 | 23:42:36 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:37 INFO - PROCESS | 13262 | RSS: Main: 188071936 23:42:37 INFO - PROCESS | 13262 | 23:42:40 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:40 INFO - PROCESS | 13262 | RSS: Main: 223076352 23:42:40 INFO - PROCESS | 13262 | 23:42:44 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50064/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:44 INFO - PROCESS | 13262 | RSS: Main: 222064640 23:42:44 INFO - PROCESS | 13262 | 23:42:47 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50064/tests/kraken/driver.html?testName=json-parse-financial) 23:42:48 INFO - PROCESS | 13262 | RSS: Main: 222367744 23:42:48 INFO - PROCESS | 13262 | 23:42:49 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:50 INFO - PROCESS | 13262 | RSS: Main: 200925184 23:42:50 INFO - PROCESS | 13262 | 23:42:52 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:52 INFO - PROCESS | 13262 | RSS: Main: 201314304 23:42:52 INFO - PROCESS | 13262 | 23:42:54 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:42:55 INFO - PROCESS | 13262 | RSS: Main: 206876672 23:42:55 INFO - PROCESS | 13262 | 23:42:57 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:42:58 INFO - PROCESS | 13262 | RSS: Main: 211615744 23:42:58 INFO - PROCESS | 13262 | 23:43:01 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:43:01 INFO - PROCESS | 13262 | RSS: Main: 211677184 23:43:01 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | Cycle 1(1): loaded http://localhost:50064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50064/tests/kraken/driver.html?testName=ai-astar) 23:43:03 INFO - PROCESS | 13262 | RSS: Main: 254517248 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | __start_tp_report 23:43:03 INFO - PROCESS | 13262 | _x_x_mozilla_page_load 23:43:03 INFO - PROCESS | 13262 | _x_x_mozilla_page_load_details 23:43:03 INFO - PROCESS | 13262 | |i|pagename|runs| 23:43:03 INFO - PROCESS | 13262 | |0;ai-astar;111;103;108;110;111;110;109;110;111;109 23:43:03 INFO - PROCESS | 13262 | |1;audio-beat-detection;147;139;127;176;132;126;153;124;152;124 23:43:03 INFO - PROCESS | 13262 | |2;audio-dft;161;159;159;160;161;162;161;161;161;160 23:43:03 INFO - PROCESS | 13262 | |3;audio-fft;74;75;78;128;75;75;75;76;102;74 23:43:03 INFO - PROCESS | 13262 | |4;audio-oscillator;84;85;112;84;84;84;112;84;84;122 23:43:03 INFO - PROCESS | 13262 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;116;117 23:43:03 INFO - PROCESS | 13262 | |6;imaging-darkroom;145;146;146;145;146;145;146;146;146;146 23:43:03 INFO - PROCESS | 13262 | |7;imaging-desaturate;95;95;95;94;94;94;95;95;94;95 23:43:03 INFO - PROCESS | 13262 | |8;json-parse-financial;49;50;52;51;51;51;55;51;53;50 23:43:03 INFO - PROCESS | 13262 | |9;json-stringify-tinderbox;61;60;60;59;60;59;59;59;59;58 23:43:03 INFO - PROCESS | 13262 | |10;stanford-crypto-aes;76;76;75;75;77;77;78;80;105;77 23:43:03 INFO - PROCESS | 13262 | |11;stanford-crypto-ccm;132;122;131;121;116;122;123;117;132;125 23:43:03 INFO - PROCESS | 13262 | |12;stanford-crypto-pbkdf2;158;155;154;155;157;159;151;159;151;153 23:43:03 INFO - PROCESS | 13262 | |13;stanford-crypto-sha256-iterative;62;61;63;62;62;65;61;60;59;59 23:43:03 INFO - PROCESS | 13262 | __end_tp_report 23:43:03 INFO - PROCESS | 13262 | __start_cc_report 23:43:03 INFO - PROCESS | 13262 | _x_x_mozilla_cycle_collect,1601 23:43:03 INFO - PROCESS | 13262 | __end_cc_report 23:43:03 INFO - PROCESS | 13262 | __startTimestamp1468478583584__endTimestamp 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | ------- Summary: start ------- 23:43:03 INFO - PROCESS | 13262 | Number of tests: 14 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.39 (2.2%) stddev-sans-first:2.45 23:43:03 INFO - PROCESS | 13262 | Values: 111.0 103.0 108.0 110.0 111.0 110.0 109.0 110.0 111.0 109.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:143.00 stddev:17.00 (11.9%) stddev-sans-first:17.84 23:43:03 INFO - PROCESS | 13262 | Values: 147.0 139.0 127.0 176.0 132.0 126.0 153.0 124.0 152.0 124.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 23:43:03 INFO - PROCESS | 13262 | Values: 161.0 159.0 159.0 160.0 161.0 162.0 161.0 161.0 161.0 160.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:17.88 (23.8%) stddev-sans-first:18.65 23:43:03 INFO - PROCESS | 13262 | Values: 74.0 75.0 78.0 128.0 75.0 75.0 75.0 76.0 102.0 74.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:15.31 (18.2%) stddev-sans-first:15.85 23:43:03 INFO - PROCESS | 13262 | Values: 84.0 85.0 112.0 84.0 84.0 84.0 112.0 84.0 84.0 122.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:43:03 INFO - PROCESS | 13262 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 23:43:03 INFO - PROCESS | 13262 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:43:03 INFO - PROCESS | 13262 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.70 (3.3%) stddev-sans-first:1.59 23:43:03 INFO - PROCESS | 13262 | Values: 49.0 50.0 52.0 51.0 51.0 51.0 55.0 51.0 53.0 50.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 23:43:03 INFO - PROCESS | 13262 | Values: 61.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 58.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:77.00 stddev:9.05 (11.7%) stddev-sans-first:9.50 23:43:03 INFO - PROCESS | 13262 | Values: 76.0 76.0 75.0 75.0 77.0 77.0 78.0 80.0 105.0 77.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:5.86 (4.7%) stddev-sans-first:5.47 23:43:03 INFO - PROCESS | 13262 | Values: 132.0 122.0 131.0 121.0 116.0 122.0 123.0 117.0 132.0 125.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:3.01 (1.9%) stddev-sans-first:3.02 23:43:03 INFO - PROCESS | 13262 | Values: 158.0 155.0 154.0 155.0 157.0 159.0 151.0 159.0 151.0 153.0 23:43:03 INFO - PROCESS | 13262 | 23:43:03 INFO - PROCESS | 13262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:1.84 (3.0%) stddev-sans-first:1.94 23:43:03 INFO - PROCESS | 13262 | Values: 62.0 61.0 63.0 62.0 62.0 65.0 61.0 60.0 59.0 59.0 23:43:03 INFO - PROCESS | 13262 | -------- Summary: end -------- 23:43:03 INFO - PROCESS | 13262 | 23:43:04 INFO - TEST-INFO | 13262: exit 0 23:43:04 INFO - TEST-OK | kraken | took 60334ms 23:43:04 INFO - SUITE-END | took 1173s 23:43:04 INFO - Completed test suite (00:19:33) 23:43:04 INFO - javascript benchmark 23:43:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.8203798791064, 3270.1988012936827, 3280.6391296957318, 3306.553615261939, 3321.0867011571813, 5354.437784032679, 5419.729013549321, 5420.268263784388, 5429.945700542993, 5446.2919820423385, 5392.649477783951, 5423.566114710824, 5438.428964958682, 5452.509274165324, 5455.236266922624, 4819.108464933981, 4900.289458028584, 4922.114019476493, 4959.057779021974, 5013.172826483626, 4818.229083346665, 4947.901041979158, 4983.078130545842, 4983.07813054586, 4987.127252730776, 4924.0, 4936.679115857458, 4953.702777833323, 4961.0, 4966.329545511364, 5036.597072234213, 5038.924416133761, 5051.87370315745, 5056.216286475602, 5081.898362032739, 4842.249451335048, 4875.926861097087, 4904.215325547931, 4950.727709975949, 4981.875453113665, 5263.078961181778, 5277.076511610453, 5279.260903473479, 5299.019681358923, 5341.092014357569, 5648.209250704905, 5742.7415766290615, 5749.511291540224, 5794.855128621818, 5799.710014499258, 5713.057345537981, 5765.509931655814, 5789.652620842763, 5825.941740582624, 5849.385814489502, 5457.645253058538, 5497.532709719639, 5503.559715222773, 5503.862403439946, 5505.807296744595, 5773.711314434261, 5980.491658209101, 5981.940180598225, 5984.042553191469, 5986.670733109634, 5600.0759874620235, 5627.212190293362, 5654.095344744821, 5707.571932105108, 5729.541636669056, 5774.48029677331, 5781.219535362757, 5781.682007489629, 5809.477147056785, 5811.4479124483105, 5549.139883318092, 5638.661680299195, 5704.0, 5705.74324155414, 5734.254546908958, 5706.28671416073, 5778.855528611818, 5789.131630255411, 5797.275340582427, 5822.446867547576, 4480.820767169342, 4484.349769283501, 4485.842995495142, 4489.7979590918485, 4510.436195475566, 3925.3326934420647, 3945.270125026879, 3993.66053885423, 4014.1770936957855, 4053.0677944073027, 5504.889902201933, 5529.557635389159, 5535.778568857281, 5537.501624853702, 5542.0, 5805.390434004369, 5812.360640329561, 5813.331466881363, 5818.040023396177, 5854.765809367577, 5361.249425080492, 5428.077226871442, 5472.753726082256, 5474.945250547523, 5521.585881058937, 4946.579540739078, 4974.552290293891, 4977.452480227172, 4979.2033274676605, 4996.2505624156665, 5824.44667756554, 5930.466258036798, 6005.279366476051, 6014.338422773491, 6021.2473440819895, 5708.286464191976, 5736.082226843685, 5769.451902069297, 5819.854503637443, 5823.621464604787, 5965.433283838029, 5972.462478376967, 5980.19267398913, 5981.102834574848, 6051.969740151271, 5529.281193444826, 5616.915746263728, 5713.771449141987, 5725.541956643542, 5733.541316694738, 5753.223314852608, 5826.242588463472, 5828.970855145697, 5835.153902684172, 5870.324912635102, 5594.300712410949, 5662.207290979184, 5664.49019588239, 5664.915026274692, 5668.659880407189, 5472.699001554953, 5521.503064724194, 5535.501804837584, 5631.662100273997, 5645.463680950304, 5554.166874968787, 5555.527780138734, 5555.666660000413, 5564.610477266552, 5580.023495888122, 5615.943840561542, 5659.122835960433, 5670.858228544319, 5676.4323567642905, 5682.659040457585, 5351.063563876228, 5436.320459942507, 5498.80754173602, 5519.006578815852, 5586.581006424453], "value": 5341.009000164522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7194082810665, 630.4294613374894, 651.8272657745696, 657.4543129202763, 666.6300203387118, 33538.329233415316, 36681.633183668186, 46156.76921615395, 47334.52665473344, 47701.0, 49151.262731058974, 49491.50508494914, 49572.0, 49631.0, 49639.25541116886, 9027.729168124966, 9172.495512746797, 9174.26605871532, 9179.403338782991, 9181.632734690604, 8336.62485188165, 10991.835122473129, 11253.324800511995, 11265.662030139109, 11266.887331126707, 10968.451577421138, 11050.944745276262, 11094.55621775128, 11444.256123351997, 11457.713557161054, 8230.300424463927, 8432.451890627151, 11226.32642041476, 11279.718007049889, 11328.773424531504, 10711.785764284748, 11092.1126309895, 11101.777964440747, 11472.770544589144, 11495.2528085675, 45671.0, 45679.31481027787, 45844.312335314666, 46144.07711845744, 46265.768671156766, 3555.8044307563073, 3897.80510974453, 3924.921501569981, 3967.761934283952, 4326.870193894189, 34687.0, 34824.12939676503, 35173.648263517294, 35622.10944726376, 36481.81759091187, 4684.156851766681, 4736.407949006374, 4771.355866957951, 4792.233242681189, 4919.557239848395, 408498.0, 410838.0, 411773.0, 412340.0, 412655.0, 71799.64100179466, 72144.0, 72442.0, 72586.27413725901, 72606.0, 41317.79341103335, 42167.57832421637, 42189.57810421918, 43874.341884871756, 43926.560734392886, 17459.738103928452, 17604.823951760576, 17671.646567068587, 17683.0, 17686.557836053944, 12612.0, 12833.743325133444, 13037.804432933513, 13050.216986980811, 13156.342182890818, 22419.55160896773, 22461.213857514907, 22519.0, 22696.43258918507, 22714.09143634236, 8052.879206811903, 8084.919150808534, 8138.796530086677, 8153.510789352657, 8246.340292776684, 1024.2011231239644, 1095.8684957805115, 1106.1206340958956, 1109.8557187565564, 1188.013948422807, 33733.83133084319, 33782.0, 34265.828670856485, 34392.14019649529, 34592.654073459445, 1032.948352582368, 1203.9217450865665, 1214.5324050240722, 1227.8772122787827, 1267.8161666558483, 17306.740398894028, 17522.912385438245, 17645.205965731573, 17950.281988720304, 18037.7294340585, 554590.0, 555447.0, 555691.0, 557360.0, 557536.0, 64385.67807160934, 66045.0, 66076.66961665257, 66124.6693766528, 66135.66932165404, 1358.7486315031751, 1412.6468382904275, 1459.8832093432713, 1465.6116129225763, 1471.808664873581, 34321.313573727886, 35359.64640353563, 35589.1102722434, 36092.819535902156, 36238.4564231542, 54352.72823635856, 55269.0, 55283.72358138183, 55360.72319638376, 55451.72274138604, 412347.0, 421680.0, 422311.0, 422634.0, 424161.0, 27570.17289481319, 28328.291792705346, 28346.433071338044, 29907.401851962404, 30906.845465773426, 47189.0, 52786.472135278156, 52905.47094529006, 53230.4676953241, 53271.46728532665, 42819.5718042828, 43423.56576434321, 43625.78187109171, 44083.77958110189, 45001.54998450105, 40950.60725536341, 44984.32523512215, 45379.092418150794, 45410.77294613506, 46526.53473465222, 43459.0, 43986.34020489759, 44516.33225501555, 45099.0, 45255.0, 38256.0, 39142.412863806494, 39207.80396098001, 39385.606143938196, 39408.40887386634, 29363.85318073396, 29420.85289573624, 29465.084769489913, 29582.852085739432, 30047.549286760277], "value": 21742.092102811777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.80973561897156, 427.2523084601947, 427.5553424438584, 431.49515067371175, 436.8602047344849, 18489.630207395843, 19779.307724229653, 20412.183512659496, 20711.689324660143, 20743.896280518613, 17336.306547738077, 17402.47792566222, 17582.384616538424, 17638.559036024075, 17854.196561154746, 5581.776728930838, 5710.371859095496, 5815.098659707731, 5827.825165245049, 5830.0, 4112.0, 5665.348484924245, 5711.428857114297, 6042.607230530023, 6363.0773537836985, 6460.127882735817, 6484.221893372778, 6489.383508566679, 6490.643014634217, 6499.057636642684, 6358.141650877119, 6424.967875160618, 6518.120053792724, 6527.575707579016, 6533.673316334188, 3806.3909774435956, 5475.315585551806, 5773.566982476331, 5783.363829978699, 5791.739371728282, 23573.528529429488, 23914.521709565885, 24012.399690007715, 24061.759382406126, 24140.758592414026, 2455.5211733711935, 2556.987215063931, 2871.497487939623, 2942.279141610319, 3058.2660161561066, 14695.26523673812, 14765.557033289018, 14913.627159320995, 15010.699786004328, 15143.242837858063, 2039.734834471524, 2079.3450063230034, 2132.402927180392, 2153.06341741343, 2199.538096999632, 56250.43749562493, 81771.0, 86157.56921215354, 86185.0, 87942.0, 10494.580216791242, 10504.947475262576, 11025.669229923114, 11274.943625281821, 11622.0, 14926.328315225841, 15082.849171508144, 15088.094714317176, 15089.47186848455, 15092.698146037017, 8358.665653373797, 8397.622107005078, 8461.576921153917, 8682.6526938923, 8694.521801300989, 8580.613872375758, 8611.61247743853, 8638.740837774876, 8686.305095592465, 8780.956095219482, 6847.417969472651, 7058.0, 7123.89314160288, 7126.714931402789, 7128.251533589002, 1756.1264105768194, 1947.766268047815, 1978.2383782243653, 2096.433962830027, 2097.4022403614895, 979.2215188924822, 1104.2215238257008, 1115.9497822598003, 1116.0680831505622, 1160.8897154770284, 19298.4210473686, 19535.0, 19776.0, 19819.504512387306, 20004.099815508336, 1082.5345101606385, 1119.2445099557765, 1127.7800828838463, 1130.3613458396144, 1148.2593727046008, 11256.15578831591, 11393.772124557463, 11449.370284634258, 11513.251638643462, 11544.595939142258, 506185.0, 508126.0, 511988.0, 513944.0, 518931.0, 88534.0, 91774.0, 91780.0, 106730.46634766777, 107251.0, 1066.8719753629614, 1067.4716015572342, 1112.7551938573502, 1114.1810769084716, 1121.4897221764077, 14295.928520357747, 16686.0, 17203.225854836313, 17700.380486682905, 17716.114194289978, 40027.79986100051, 41861.0, 41931.37102943519, 41931.7903410481, 43009.56990430181, 57867.71066144642, 59036.70481647564, 59368.70315648394, 59708.0, 60259.69870150621, 8966.68616598416, 9048.773780655536, 9054.777605023237, 9333.53332333367, 9380.0, 13230.206187628773, 13673.31633418345, 13766.0, 13902.374393152535, 13929.0, 12001.579944701894, 12038.157328987238, 12067.155299128977, 12138.211016283913, 12150.270983741004, 11711.180217385043, 11838.28970261787, 11883.881161188277, 11982.760344793229, 12131.696707582381, 11848.229865058744, 12316.938415307866, 12409.93795031019, 12586.559470418491, 12612.684682883002, 8002.9599852000365, 8328.541930193898, 8568.614412351335, 9040.095990400907, 9305.162535371848, 11907.82138267944, 12545.247285162919, 12725.236485810881, 12828.294443805307, 12836.871631283568], "value": 9791.740825047342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.1550285331653, 1584.0812328849267, 1604.5026041927003, 1786.794518630358, 1914.684077127275, 9198.44809311441, 9556.99999999999, 9559.091886270802, 9844.261680373966, 9861.161801246884, 9527.857082143755, 9745.31782775206, 9760.85358719618, 9795.363301385423, 9797.902020979787, 2201.218567408563, 2266.0, 2268.523610041885, 2534.581794003987, 2558.7441255874355, 2446.987765061172, 2529.178017144426, 2534.8986040558357, 2536.4800215955684, 2537.835040722347, 2516.6225066240027, 2522.8360156589856, 2534.721180670125, 2535.1253817432957, 2549.987250063747, 2187.73747150343, 2261.9660705089436, 2528.8356256843244, 2561.3852675357966, 2563.384787650969, 2233.966490502644, 2360.1857359211044, 2423.0, 2423.0, 2432.9391765205833, 9267.860982085274, 9285.628574856997, 9316.813663726754, 9332.953335233347, 9336.579853906522, 5383.623146379755, 5503.036968530531, 5504.944950550484, 5515.641483303572, 5516.641418307797, 3680.5583330000304, 3798.0694729791103, 3808.314503389389, 3843.250566139604, 3853.7495062820826, 1243.4031664800946, 1281.9038572107129, 1283.159530507519, 1286.871312868715, 1291.2252648410972, 13146.737065258641, 13156.802647960289, 13161.802572961413, 13221.86778132216, 13226.470941162343, 4986.925196122061, 4992.2761199626575, 5085.186370180827, 5185.196294574347, 5203.334932821536, 11097.667069987914, 11105.444727763579, 11119.054880335101, 11123.833142502868, 11145.16411269158, 5523.944760552424, 5571.4428557143965, 5583.972080139573, 5586.86032849182, 5587.217789509472, 4414.735115893057, 4589.770511474413, 4973.1297023020825, 5010.749462526859, 5033.370828646419, 4422.911541769211, 4432.534583868712, 4443.955560444354, 4477.70894891831, 4542.341360502709, 1386.6671998720235, 1387.1053170704838, 1394.5816255123625, 1404.6769243073945, 1414.2292450614234, 913.2009491694768, 1001.4942454060798, 1004.2568499310457, 1086.5708045322053, 1089.2593036735095, 6622.357703263186, 6770.32296770319, 6798.388145066968, 6805.523613347018, 6812.114425124702, 476.5568021739815, 479.7361451201825, 487.8536439068265, 505.7471264367816, 511.0162936347516, 4692.741899195509, 4719.032598317337, 4723.267893476516, 4723.551262630044, 4749.691270067435, 12018.338991355384, 12366.134370593973, 12376.443060062138, 12399.25604463735, 12425.0, 12094.0, 12146.695391625224, 12176.756464870654, 12385.504579816887, 12390.194637348544, 9078.818423631623, 9122.179003889682, 9123.452592844318, 9204.539773011322, 9327.300452466228, 6727.697253623696, 6802.3537763912345, 6823.55646882951, 6842.726290948505, 6905.965470172617, 11009.83485247738, 11069.778604428027, 11364.829527556927, 11376.886231137583, 11473.13951453661, 11457.140714446283, 11574.942125289319, 11578.94210528942, 11587.478563464496, 11690.47392867306, 7643.88534171999, 7704.537727736354, 8604.354673399645, 8758.430702004349, 8798.47209167452, 9548.474833884204, 9632.325737198329, 9646.131848133702, 9697.369670971364, 9721.368111072758, 8487.278581320657, 8657.437266577652, 8699.217070463688, 8719.128087191484, 8799.780005499657, 8225.753227403187, 8271.875921861298, 8460.53467059293, 8486.575671216538, 8501.787455313666, 7928.08826984881, 8000.679972801023, 8008.879866801886, 8009.679612815422, 8016.7194148204535, 5760.423957604206, 5857.502112320501, 5897.3807750185615, 5944.970275148769, 5995.340512543529, 5801.448862358069, 5802.100674395476, 5819.679917604572, 5908.0, 5942.257217847769], "value": 4986.333750039823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.69844283137917, 361.4181168319006, 365.2275437449793, 365.674549650811, 367.28746232309317, 5415.620906536539, 5419.566434685225, 5445.264889239947, 5450.509454149126, 5467.535259502942, 5101.413337466192, 5201.191356667405, 5222.4255331913455, 5248.580113590913, 5400.135978243482, 4159.459270294872, 4163.354680024593, 4276.486821581399, 4280.743155410685, 4314.266574682296, 4217.1987322408795, 4246.893827654302, 4252.744835309876, 4265.87202383929, 4270.67969902257, 4146.771927543984, 4219.810108545123, 4240.897366684669, 4241.851535196269, 4275.636570891478, 4019.919601607981, 4128.545859955402, 4229.873103806891, 4244.851430199959, 4244.915101697949, 3787.6401741834484, 3788.488554045196, 3799.202167544819, 3815.618438156162, 3819.3698039823394, 5174.353205849269, 5195.870103247411, 5209.505097015777, 5212.765425555821, 5238.502342277516, 4658.697184683018, 4754.643401744883, 4761.119192949315, 4822.614190864722, 4947.92578111325, 5457.608309880995, 5518.33779946405, 5538.889222215533, 5581.66040150365, 5588.077967135418, 4099.733517321364, 4102.651274641659, 4117.958820411787, 4135.17296540693, 4144.3990621359735, 5614.410486898858, 5803.026970829896, 5815.680137592431, 5830.416958304136, 5884.293884733816, 4273.294906340419, 4274.5939135782055, 4275.764832934218, 4304.870853874389, 4308.246056940023, 4332.610065094157, 4340.110277393127, 4342.392065110887, 4346.326319420432, 4360.672949528798, 4637.791299391535, 4805.519448055236, 4827.831025914146, 4898.975505122452, 4909.214525675875, 5596.496315331639, 5636.718164091779, 5649.180868774005, 5650.208970744099, 5655.830325090254, 1454.2510607037384, 1466.8631810346853, 1472.5140703567797, 1474.4176050460223, 1476.0995792566525, 935.6351023100996, 959.3332633819429, 966.1353088985319, 967.8403063494444, 980.9607615695435, 4909.772556860785, 4933.728644924492, 4973.378327709036, 4977.278294647256, 5008.449070602303, 5194.6104042196985, 5196.480351964773, 5224.634275600747, 5261.184516399964, 5270.393904701008, 5018.849434516897, 5031.723255220924, 5268.733385301138, 5367.329083864517, 5431.67409955396, 3054.801437906529, 3071.508558630608, 3073.431415188197, 3081.0, 3092.768042396829, 5854.385289544536, 6072.726727297282, 6081.148639190517, 6085.482733967574, 6090.482309003784, 5909.527237820964, 5922.615030023035, 5937.70311484424, 5940.613860099166, 5944.85137871548, 6028.638281703112, 6082.783443311356, 6101.725422356093, 6105.664188469588, 6107.267127944586, 5576.33084029919, 5788.710564471676, 5797.159411885337, 5807.796727114531, 5812.505936995402, 5738.741756620879, 5743.4543718346695, 5752.482276595127, 5754.53963682896, 5755.5971082025535, 5894.616849904743, 6009.95661475083, 6089.2997305310455, 6101.511879049576, 6111.7249723763425, 4176.498820141603, 4198.433211516406, 4201.13876655291, 4204.0, 4206.411102445599, 5755.985405108178, 5780.595358325045, 5837.124431335334, 5883.852903677443, 5905.379935106924, 5498.917516237339, 5688.54491640676, 5696.259486266758, 5784.652920824764, 5785.681787501728, 5577.916331255115, 5583.609147359646, 5617.43825617435, 5660.830175094754, 5667.316244440982, 5559.555235581063, 5618.550515958632, 5632.690202038763, 5647.463490968352, 5671.234383358194, 5468.535174510212, 5691.089425691869, 5692.260006199168, 5700.261420266858, 5706.8586282744445, 5506.779728810803, 5527.53015993645, 5552.639078459887, 5562.554995600423, 5580.274564306615], "value": 4317.3144163840825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.8335024670192, 857.4812238595649, 864.2351518905771, 891.5586784541653, 895.9238464730502, 15482.458113966013, 16895.32418703252, 17274.049927253996, 17315.0, 17348.82651173488, 15160.696786064273, 15480.69038619227, 15548.689026219468, 15549.222538873068, 15575.37698492059, 721.6391804097951, 839.8026463781038, 859.7893516088567, 869.5521806269776, 872.9825403491926, 855.5551113421018, 855.7732200966749, 857.3826844671827, 858.0347109501811, 858.0861382627513, 918.6004088221612, 919.6827094652334, 920.4707293306342, 920.8158368326361, 921.1341339141219, 749.3068911257066, 878.6265837019241, 897.228383590112, 897.6050537763364, 906.5331354352513, 664.4817042706649, 667.4326822201139, 667.6094484726441, 667.9699413526403, 668.6589839182003, 14354.92822535891, 14381.424743010268, 14389.13665180082, 14443.566692999228, 14491.637709057359, 14804.333804978802, 14995.100293982287, 15200.315985780666, 15238.314275857612, 15497.45758898433, 12510.81233781494, 12584.622461326175, 12618.116731828775, 13872.722545549033, 14121.576352709435, 4748.501407352247, 4794.280857871312, 4794.976025119887, 4858.5384388483035, 4862.5380588844, 77079.0, 77319.6134019332, 77324.61337693276, 80246.0, 80700.19299806985, 12308.630741077783, 12322.373712799037, 12517.248965062125, 12558.560450384375, 12709.0, 21609.135634574755, 21658.02538885754, 21673.566528669337, 21776.0, 21778.564428711335, 8912.376133670581, 8951.32865035125, 9033.096690330914, 9098.590563424661, 9251.953740231256, 5050.217216331401, 5093.592512599057, 5107.61692873036, 5150.845474635767, 5188.662736922088, 3776.4901738264984, 4170.70805043644, 4350.8042138103865, 4353.825846966086, 4359.346098085249, 593.6289818863211, 709.0, 715.5492040014757, 717.5156769180886, 728.3372131360543, 633.7280848159309, 636.7039326713101, 764.9349805266614, 774.8798936164903, 789.8933643957993, 10384.584616615251, 10679.51942162589, 10679.57281708723, 10765.677029688964, 10785.083267922157, 569.0984490830036, 694.6283738200038, 709.5387997801367, 762.1806557950225, 802.4904185842032, 4773.498782627774, 4823.057934659854, 4908.975455122773, 5029.748512574357, 5051.797928082836, 123740.0, 123789.38105309416, 123801.0, 125205.37397312955, 130041.34979325043, 105703.0, 105855.0, 106485.46757266164, 107564.0, 109188.0, 76654.616726916, 77845.0, 78821.60589197018, 86361.13638863657, 89009.55495222482, 10639.574417023232, 10771.299865508718, 10799.0, 10914.345139291669, 11077.11383089367, 49193.0, 50001.49998499968, 53506.0, 55109.1733624004, 56192.0, 74856.0, 77892.0, 79041.0, 79953.2004679969, 80449.0, 13353.599392018255, 13809.309534523434, 13991.720165596835, 14099.295035247991, 14102.929485352508, 15256.694866102394, 15285.77071343953, 15711.68576628484, 16041.679166416372, 16219.35122595083, 12547.623571292876, 12651.620451386472, 13244.27156506363, 14235.50175743844, 14377.56867293983, 15007.324670390077, 15084.773728394302, 15104.622384440478, 15610.609734756721, 15699.0, 14429.567112986628, 14613.0, 14640.780388293972, 14912.850871491146, 15169.393224271347, 11793.29240245588, 12219.75560488803, 12321.383930803604, 12395.75208495807, 12758.106932514635, 12391.132620716824, 12771.361431928552, 12828.486860525474, 12991.0, 13026.47894084226], "value": 8082.931465512058, "unit": "score"}], "name": "dromaeo_css", "value": 7633.6520604977495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 108.0, 110.0, 111.0, 110.0, 109.0, 110.0, 111.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 127.0, 176.0, 132.0, 126.0, 153.0, 124.0, 152.0, 124.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 128.0, 75.0, 75.0, 75.0, 76.0, 102.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 84.0, 84.0, 84.0, 112.0, 84.0, 84.0, 122.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 52.0, 51.0, 51.0, 51.0, 55.0, 51.0, 53.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 77.0, 77.0, 78.0, 80.0, 105.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 131.0, 121.0, 116.0, 122.0, 123.0, 117.0, 132.0, 125.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 154.0, 155.0, 157.0, 159.0, 151.0, 159.0, 151.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 62.0, 65.0, 61.0, 60.0, 59.0, 59.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1474.3, "alertThreshold": 2.0}]} 23:43:04 INFO - Return code: 0 23:43:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:43:04 ERROR - # TBPL SUCCESS # 23:43:04 INFO - Running post-action listener: _resource_record_post_action 23:43:04 INFO - ##### 23:43:04 INFO - ##### Finished run-tests step (success) 23:43:04 INFO - ##### 23:43:04 INFO - Running post-run listener: _resource_record_post_run 23:43:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 515416064; Read time: 20; Write time: 690000 23:43:04 INFO - TinderboxPrint: CPU usage
13.1% 23:43:04 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 23:43:04 INFO - TinderboxPrint: I/O write bytes / time
515,416,064 / 690,000 23:43:04 INFO - TinderboxPrint: CPU idle
8,259.2 (86.9%) 23:43:04 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 23:43:04 INFO - TinderboxPrint: Swap in / out
0 / 0 23:43:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259702784; Read time: 0; Write time: 380264 23:43:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 251760640; Read time: 20; Write time: 308976 23:43:05 INFO - Running post-run listener: _upload_blobber_files 23:43:05 INFO - Blob upload gear active. 23:43:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:43:05 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 23:43:05 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'] 23:43:05 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 23:43:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:06 INFO - (blobuploader) - INFO - Done attempting. 23:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:07 INFO - (blobuploader) - INFO - Done attempting. 23:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:11 INFO - (blobuploader) - INFO - Done attempting. 23:43:11 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:11 INFO - Return code: 0 23:43:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b19364d5fb359c3e28fac4b408e79d465ad43024e047ad528eeb194e55ef2250195e04ac7bc098cfe23b159a27698c8aa6f4f23c4254f89db750951bde92d818", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/282803184550877472d034c451422a4e925cb6ac359aed4875ce987e059363e72637488d4bd733bb56cd03a509d3b726f4bcde1f98e0e824ebc3cad38b457d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ebd2b2775c67dfd802a350a17e5225010b2cea5786d5ae463ada40dbf410496c8c721fb0eba77dd3fe79a4240159c1f340dc119d411922c38e499ce8cc6c9d4"} 23:43:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:11 INFO - Contents: 23:43:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b19364d5fb359c3e28fac4b408e79d465ad43024e047ad528eeb194e55ef2250195e04ac7bc098cfe23b159a27698c8aa6f4f23c4254f89db750951bde92d818", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/282803184550877472d034c451422a4e925cb6ac359aed4875ce987e059363e72637488d4bd733bb56cd03a509d3b726f4bcde1f98e0e824ebc3cad38b457d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ebd2b2775c67dfd802a350a17e5225010b2cea5786d5ae463ada40dbf410496c8c721fb0eba77dd3fe79a4240159c1f340dc119d411922c38e499ce8cc6c9d4"} 23:43:11 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:11 INFO - Copying logs to upload dir... 23:43:11 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.535078 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:43:10.913562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:10.917751) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b19364d5fb359c3e28fac4b408e79d465ad43024e047ad528eeb194e55ef2250195e04ac7bc098cfe23b159a27698c8aa6f4f23c4254f89db750951bde92d818", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/282803184550877472d034c451422a4e925cb6ac359aed4875ce987e059363e72637488d4bd733bb56cd03a509d3b726f4bcde1f98e0e824ebc3cad38b457d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ebd2b2775c67dfd802a350a17e5225010b2cea5786d5ae463ada40dbf410496c8c721fb0eba77dd3fe79a4240159c1f340dc119d411922c38e499ce8cc6c9d4"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b19364d5fb359c3e28fac4b408e79d465ad43024e047ad528eeb194e55ef2250195e04ac7bc098cfe23b159a27698c8aa6f4f23c4254f89db750951bde92d818", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/282803184550877472d034c451422a4e925cb6ac359aed4875ce987e059363e72637488d4bd733bb56cd03a509d3b726f4bcde1f98e0e824ebc3cad38b457d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ebd2b2775c67dfd802a350a17e5225010b2cea5786d5ae463ada40dbf410496c8c721fb0eba77dd3fe79a4240159c1f340dc119d411922c38e499ce8cc6c9d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:10.945928) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:10.946380) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468477358.47363-91419377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:11.030101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:11.030581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:11.031128) ========= ========= Total master_lag: 0.18 =========