builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1467891200.98 results: success (0) buildid: 20160706164923 builduid: cf5d7723f75c49b7843667d4b06ac06d revision: c1342bdc08a949c74278e59958dbecbc6f138258 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:20.984630) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:20.985105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:20.985435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:21.000970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:21.001622) ========= 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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 04:33:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.4M=0s 2016-07-07 04:33:21 (36.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137999 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:21.180363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:21.180751) ========= 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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018893 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:21.230617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 04:33:21.231037) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c1342bdc08a949c74278e59958dbecbc6f138258 --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 c1342bdc08a949c74278e59958dbecbc6f138258 --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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 04:33:21,467 truncating revision to first 12 chars 2016-07-07 04:33:21,467 Setting DEBUG logging. 2016-07-07 04:33:21,467 attempt 1/10 2016-07-07 04:33:21,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c1342bdc08a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 04:33:22,494 unpacking tar archive at: mozilla-aurora-c1342bdc08a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361267 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 04:33:22.632975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:22.633369) ========= script_repo_revision: c1342bdc08a949c74278e59958dbecbc6f138258 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:22.633829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:22.634141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:33:22.645810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-07 04:33:22.646214) ========= /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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:22 INFO - MultiFileLogger online at 20160707 04:33:22 in /builds/slave/test 04:33:22 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 04:33:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:22 INFO - {'append_to_log': False, 04:33:22 INFO - 'base_work_dir': '/builds/slave/test', 04:33:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:33:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:22 INFO - 'branch': 'Mozilla-Aurora', 04:33:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:22 INFO - 'config_files': ('talos/linux_config.py',), 04:33:22 INFO - 'default_actions': ('clobber', 04:33:22 INFO - 'read-buildbot-config', 04:33:22 INFO - 'download-and-extract', 04:33:22 INFO - 'populate-webroot', 04:33:22 INFO - 'create-virtualenv', 04:33:22 INFO - 'install', 04:33:22 INFO - 'run-tests'), 04:33:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:22 INFO - 'download_minidump_stackwalk': True, 04:33:22 INFO - 'download_symbols': 'ondemand', 04:33:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:22 INFO - 'installer_path': 'installer.exe', 04:33:22 INFO - 'log_level': 'info', 04:33:22 INFO - 'log_name': 'talos', 04:33:22 INFO - 'log_to_console': True, 04:33:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:22 INFO - 'opt_config_files': (), 04:33:22 INFO - 'pip_index': False, 04:33:22 INFO - 'sps_profile': False, 04:33:22 INFO - 'sps_profile_interval': 0, 04:33:22 INFO - 'suite': 'dromaeojs', 04:33:22 INFO - 'system_bits': '32', 04:33:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:22 INFO - 'title': 'talos-linux64-ix-026', 04:33:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:22 INFO - 'use_talos_json': True, 04:33:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:22 INFO - 'work_dir': 'build'} 04:33:22 INFO - ##### 04:33:22 INFO - ##### Running clobber step. 04:33:22 INFO - ##### 04:33:22 INFO - Running pre-action listener: _resource_record_pre_action 04:33:22 INFO - Running main action method: clobber 04:33:22 INFO - rmtree: /builds/slave/test/build 04:33:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:23 INFO - Running post-action listener: _resource_record_post_action 04:33:23 INFO - ##### 04:33:23 INFO - ##### Finished clobber step (success) 04:33:23 INFO - ##### 04:33:23 INFO - ##### 04:33:23 INFO - ##### Running read-buildbot-config step. 04:33:23 INFO - ##### 04:33:23 INFO - Running pre-action listener: _resource_record_pre_action 04:33:23 INFO - Running main action method: read_buildbot_config 04:33:23 INFO - Using buildbot properties: 04:33:23 INFO - { 04:33:23 INFO - "project": "", 04:33:23 INFO - "product": "firefox", 04:33:23 INFO - "script_repo_revision": "production", 04:33:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:33:23 INFO - "repository": "", 04:33:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:33:23 INFO - "buildid": "20160706164923", 04:33:23 INFO - "pgo_build": "True", 04:33:23 INFO - "basedir": "/builds/slave/test", 04:33:23 INFO - "buildnumber": 407, 04:33:23 INFO - "slavename": "talos-linux64-ix-026", 04:33:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:33:23 INFO - "platform": "ubuntu64_hw", 04:33:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:33:23 INFO - "branch": "mozilla-aurora", 04:33:23 INFO - "repo_path": "releases/mozilla-aurora", 04:33:23 INFO - "revision": "c1342bdc08a949c74278e59958dbecbc6f138258", 04:33:23 INFO - "stage_platform": "linux64-pgo", 04:33:23 INFO - "builduid": "cf5d7723f75c49b7843667d4b06ac06d", 04:33:23 INFO - "slavebuilddir": "test" 04:33:23 INFO - } 04:33:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:33:23 INFO - Running post-action listener: _resource_record_post_action 04:33:23 INFO - ##### 04:33:23 INFO - ##### Finished read-buildbot-config step (success) 04:33:23 INFO - ##### 04:33:23 INFO - ##### 04:33:23 INFO - ##### Running download-and-extract step. 04:33:23 INFO - ##### 04:33:23 INFO - Running pre-action listener: _resource_record_pre_action 04:33:23 INFO - Running main action method: download_and_extract 04:33:23 INFO - mkdir: /builds/slave/test/build/tests 04:33:23 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')]} 04:33:23 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:24 INFO - Downloaded 1361 bytes. 04:33:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:33:24 INFO - Using the following test package requirements: 04:33:24 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:33:24 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:24 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:33:24 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'jsshell-linux-x86_64.zip'], 04:33:24 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:24 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:33:24 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:33:24 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:33:24 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:24 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:33:24 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:24 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:24 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:25 INFO - Downloaded 24526649 bytes. 04:33:25 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'] 04:33:25 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 04:33:26 INFO - Return code: 0 04:33:26 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 04:33:26 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')]} 04:33:26 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:33:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:28 INFO - Downloaded 24526649 bytes. 04:33:28 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'] 04:33:28 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 04:33:29 INFO - Return code: 0 04:33: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')]} 04:33:29 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:33:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:33:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:30 INFO - Downloaded 10833369 bytes. 04:33:30 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'] 04:33:30 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 04:33:30 INFO - Return code: 0 04:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:30 INFO - https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdJhTECcTwqoMOLmYmsnKg/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 04:33:33 INFO - Downloaded 63634791 bytes. 04:33:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:33 INFO - mkdir: /builds/slave/test/properties 04:33:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:33 INFO - Contents: 04:33:33 INFO - build_url:https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:33:34 INFO - Running post-action listener: _resource_record_post_action 04:33:34 INFO - Running post-action listener: set_extra_try_arguments 04:33:34 INFO - ##### 04:33:34 INFO - ##### Finished download-and-extract step (success) 04:33:34 INFO - ##### 04:33:34 INFO - ##### 04:33:34 INFO - ##### Running populate-webroot step. 04:33:34 INFO - ##### 04:33:34 INFO - Running pre-action listener: _resource_record_pre_action 04:33:34 INFO - Running main action method: populate_webroot 04:33:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:34 INFO - '--tppagecycles', 04:33:34 INFO - '7'], 04:33:34 INFO - 'tests': ['tsvgm']}}, 04:33:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['damp', 'tps']}, 04:33:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'tests': ['damp', 'tps']}, 04:33:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['dromaeo_dom']}, 04:33:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['a11yr', 04:33:34 INFO - 'ts_paint', 04:33:34 INFO - 'tpaint', 04:33:34 INFO - 'sessionrestore', 04:33:34 INFO - 'sessionrestore_no_auto_restore', 04:33:34 INFO - 'tabpaint']}, 04:33:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['tsvgx', 04:33:34 INFO - 'tsvgr_opacity', 04:33:34 INFO - 'tart', 04:33:34 INFO - 'tscrollx', 04:33:34 INFO - 'cart']}, 04:33:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:34 INFO - 'tsvgr_opacity', 04:33:34 INFO - 'tart', 04:33:34 INFO - 'tscrollx', 04:33:34 INFO - 'cart']}, 04:33:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'talos_options': ['--disable-e10s'], 04:33:34 INFO - 'tests': ['tp5o']}, 04:33:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'tests': ['tp5o']}, 04:33:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'talos_options': ['--disable-e10s', 04:33:34 INFO - '--xperf_path', 04:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:34 INFO - 'tests': ['tp5n']}, 04:33:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:34 INFO - 'talos_options': ['--xperf_path', 04:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:34 INFO - 'tests': ['tp5n']}}, 04:33:34 INFO - 'talos.zip': {'path': '', 04:33:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:34 INFO - Running post-action listener: _resource_record_post_action 04:33:34 INFO - ##### 04:33:34 INFO - ##### Finished populate-webroot step (success) 04:33:34 INFO - ##### 04:33:34 INFO - ##### 04:33:34 INFO - ##### Running create-virtualenv step. 04:33:34 INFO - ##### 04:33:34 INFO - Running pre-action listener: _resource_record_pre_action 04:33:34 INFO - Running main action method: create_virtualenv 04:33:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:34 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 04:33:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:34 INFO - Using real prefix '/usr' 04:33:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:36 INFO - Installing pip.................done. 04:33:36 INFO - Return code: 0 04:33:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:36 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 04:33:36 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 04:33:36 INFO - Using env: {'DISPLAY': ':0', 04:33:36 INFO - 'HOME': '/home/cltbld', 04:33:36 INFO - 'LANG': 'en_US.UTF-8', 04:33:36 INFO - 'LANGUAGE': 'en_US:en', 04:33:36 INFO - 'LOGNAME': 'cltbld', 04:33:36 INFO - 'MAIL': '/var/mail/cltbld', 04:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:36 INFO - 'MOZ_NO_REMOTE': '1', 04:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:36 INFO - 'NO_EM_RESTART': '1', 04:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:36 INFO - 'PWD': '/builds/slave/test', 04:33:36 INFO - 'SHELL': '/bin/bash', 04:33:36 INFO - 'SHLVL': '1', 04:33:36 INFO - 'TERM': 'linux', 04:33:36 INFO - 'TMOUT': '86400', 04:33:36 INFO - 'USER': 'cltbld', 04:33:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:36 INFO - '_': '/tools/buildbot/bin/python'} 04:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:36 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 04:33:36 INFO - Cleaning up... 04:33:36 INFO - Return code: 0 04:33:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:36 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 04:33:36 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 04:33:36 INFO - Using env: {'DISPLAY': ':0', 04:33:36 INFO - 'HOME': '/home/cltbld', 04:33:36 INFO - 'LANG': 'en_US.UTF-8', 04:33:36 INFO - 'LANGUAGE': 'en_US:en', 04:33:36 INFO - 'LOGNAME': 'cltbld', 04:33:36 INFO - 'MAIL': '/var/mail/cltbld', 04:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:36 INFO - 'MOZ_NO_REMOTE': '1', 04:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:36 INFO - 'NO_EM_RESTART': '1', 04:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:36 INFO - 'PWD': '/builds/slave/test', 04:33:36 INFO - 'SHELL': '/bin/bash', 04:33:36 INFO - 'SHLVL': '1', 04:33:36 INFO - 'TERM': 'linux', 04:33:36 INFO - 'TMOUT': '86400', 04:33:36 INFO - 'USER': 'cltbld', 04:33:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:36 INFO - '_': '/tools/buildbot/bin/python'} 04:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:37 INFO - Downloading/unpacking psutil>=3.1.1 04:33:37 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 04:33:37 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 04:33:37 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 04:33:37 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 04:33:37 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 04:33:37 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 04:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:39 INFO - Installing collected packages: psutil 04:33:39 INFO - Running setup.py install for psutil 04:33:39 INFO - building 'psutil._psutil_linux' extension 04:33:39 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 04:33:39 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 04:33:39 INFO - building 'psutil._psutil_posix' extension 04:33:39 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 04:33:39 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 04:33:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:39 INFO - Successfully installed psutil 04:33:39 INFO - Cleaning up... 04:33:39 INFO - Return code: 0 04:33:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:39 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')]} 04:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:39 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')]} 04:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:39 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:39 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 04:33:39 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 04:33:39 INFO - Using env: {'DISPLAY': ':0', 04:33:39 INFO - 'HOME': '/home/cltbld', 04:33:39 INFO - 'LANG': 'en_US.UTF-8', 04:33:39 INFO - 'LANGUAGE': 'en_US:en', 04:33:39 INFO - 'LOGNAME': 'cltbld', 04:33:39 INFO - 'MAIL': '/var/mail/cltbld', 04:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:39 INFO - 'MOZ_NO_REMOTE': '1', 04:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:39 INFO - 'NO_EM_RESTART': '1', 04:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:39 INFO - 'PWD': '/builds/slave/test', 04:33:39 INFO - 'SHELL': '/bin/bash', 04:33:39 INFO - 'SHLVL': '1', 04:33:39 INFO - 'TERM': 'linux', 04:33:39 INFO - 'TMOUT': '86400', 04:33:39 INFO - 'USER': 'cltbld', 04:33:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:39 INFO - '_': '/tools/buildbot/bin/python'} 04:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33:39 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 04:33:39 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 04:33:39 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 04:33:39 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 04:33:39 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 04:33:39 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 04:33:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:33:41 INFO - Installing collected packages: mozsystemmonitor 04:33:41 INFO - Running setup.py install for mozsystemmonitor 04:33:41 INFO - Successfully installed mozsystemmonitor 04:33:41 INFO - Cleaning up... 04:33:41 INFO - Return code: 0 04:33:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:33:41 INFO - Using env: {'DISPLAY': ':0', 04:33:41 INFO - 'HOME': '/home/cltbld', 04:33:41 INFO - 'LANG': 'en_US.UTF-8', 04:33:41 INFO - 'LANGUAGE': 'en_US:en', 04:33:41 INFO - 'LOGNAME': 'cltbld', 04:33:41 INFO - 'MAIL': '/var/mail/cltbld', 04:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:41 INFO - 'MOZ_NO_REMOTE': '1', 04:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:41 INFO - 'NO_EM_RESTART': '1', 04:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:41 INFO - 'PWD': '/builds/slave/test', 04:33:41 INFO - 'SHELL': '/bin/bash', 04:33:41 INFO - 'SHLVL': '1', 04:33:41 INFO - 'TERM': 'linux', 04:33:41 INFO - 'TMOUT': '86400', 04:33:41 INFO - 'USER': 'cltbld', 04:33:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:41 INFO - '_': '/tools/buildbot/bin/python'} 04:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:33:43 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 04:33:43 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 04:33:43 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 04:33:43 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 04:33:43 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 04:33:43 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 04:33:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:44 INFO - warning: no files found matching '*.txt' 04:33:44 INFO - no previously-included directories found matching 'build' 04:33:44 INFO - no previously-included directories found matching 'dist' 04:33:44 INFO - no previously-included directories found matching '.git*' 04:33:44 INFO - Installing collected packages: jsonschema, functools32 04:33:44 INFO - Running setup.py install for functools32 04:33:44 INFO - warning: no files found matching '*.txt' 04:33:44 INFO - no previously-included directories found matching 'build' 04:33:44 INFO - no previously-included directories found matching 'dist' 04:33:44 INFO - no previously-included directories found matching '.git*' 04:33:44 INFO - Successfully installed jsonschema functools32 04:33:44 INFO - Cleaning up... 04:33:44 INFO - Return code: 0 04:33:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:33:44 INFO - Using env: {'DISPLAY': ':0', 04:33:44 INFO - 'HOME': '/home/cltbld', 04:33:44 INFO - 'LANG': 'en_US.UTF-8', 04:33:44 INFO - 'LANGUAGE': 'en_US:en', 04:33:44 INFO - 'LOGNAME': 'cltbld', 04:33:44 INFO - 'MAIL': '/var/mail/cltbld', 04:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:44 INFO - 'MOZ_NO_REMOTE': '1', 04:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:44 INFO - 'NO_EM_RESTART': '1', 04:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:44 INFO - 'PWD': '/builds/slave/test', 04:33:44 INFO - 'SHELL': '/bin/bash', 04:33:44 INFO - 'SHLVL': '1', 04:33:44 INFO - 'TERM': 'linux', 04:33:44 INFO - 'TMOUT': '86400', 04:33:44 INFO - 'USER': 'cltbld', 04:33:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:44 INFO - '_': '/tools/buildbot/bin/python'} 04:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:47 INFO - Downloading docopt-0.6.1.tar.gz 04:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:47 INFO - Running setup.py install for blobuploader 04:33:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:47 INFO - Running setup.py install for requests 04:33:47 INFO - Running setup.py install for docopt 04:33:48 INFO - Successfully installed blobuploader requests docopt 04:33:48 INFO - Cleaning up... 04:33:48 INFO - Return code: 0 04:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:48 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:48 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 04:33:48 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 04:33:48 INFO - Using env: {'DISPLAY': ':0', 04:33:48 INFO - 'HOME': '/home/cltbld', 04:33:48 INFO - 'LANG': 'en_US.UTF-8', 04:33:48 INFO - 'LANGUAGE': 'en_US:en', 04:33:48 INFO - 'LOGNAME': 'cltbld', 04:33:48 INFO - 'MAIL': '/var/mail/cltbld', 04:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:48 INFO - 'MOZ_NO_REMOTE': '1', 04:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:48 INFO - 'NO_EM_RESTART': '1', 04:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:48 INFO - 'PWD': '/builds/slave/test', 04:33:48 INFO - 'SHELL': '/bin/bash', 04:33:48 INFO - 'SHLVL': '1', 04:33:48 INFO - 'TERM': 'linux', 04:33:48 INFO - 'TMOUT': '86400', 04:33:48 INFO - 'USER': 'cltbld', 04:33:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:48 INFO - '_': '/tools/buildbot/bin/python'} 04:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:48 INFO - Running setup.py (path:/tmp/pip-W4Vdj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:48 INFO - Running setup.py (path:/tmp/pip-_Nlq1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:48 INFO - Running setup.py (path:/tmp/pip-3TLp0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:48 INFO - Running setup.py (path:/tmp/pip-A4KC3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:48 INFO - Running setup.py (path:/tmp/pip-HYChyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:48 INFO - Running setup.py (path:/tmp/pip-eKCCFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:48 INFO - Running setup.py (path:/tmp/pip-eijIsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:48 INFO - Running setup.py (path:/tmp/pip-nNqq0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:48 INFO - Running setup.py (path:/tmp/pip-0ZKRkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:48 INFO - Running setup.py (path:/tmp/pip-B1lylF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:49 INFO - Running setup.py (path:/tmp/pip-PAvX24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:49 INFO - Running setup.py (path:/tmp/pip-9nHbMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:49 INFO - Running setup.py (path:/tmp/pip-P1sHWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:49 INFO - Running setup.py (path:/tmp/pip-UkEqWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:49 INFO - Running setup.py (path:/tmp/pip-Mt85bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:49 INFO - Running setup.py (path:/tmp/pip-P6FjY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:49 INFO - Running setup.py (path:/tmp/pip-8nCcA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:49 INFO - Running setup.py install for manifestparser 04:33:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:49 INFO - Running setup.py install for mozcrash 04:33:49 INFO - Running setup.py install for mozdebug 04:33:49 INFO - Running setup.py install for mozdevice 04:33:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:49 INFO - Running setup.py install for mozfile 04:33:50 INFO - Running setup.py install for mozhttpd 04:33:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for mozinfo 04:33:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for mozInstall 04:33:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for mozleak 04:33:50 INFO - Running setup.py install for mozlog 04:33:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for moznetwork 04:33:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for mozprocess 04:33:50 INFO - Running setup.py install for mozprofile 04:33:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:50 INFO - Running setup.py install for mozrunner 04:33:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:51 INFO - Running setup.py install for mozscreenshot 04:33:51 INFO - Running setup.py install for moztest 04:33:51 INFO - Running setup.py install for mozversion 04:33:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:51 INFO - Cleaning up... 04:33:51 INFO - Return code: 0 04:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33: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')]} 04:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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')]} 04:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:51 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:51 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 04:33:51 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 04:33:51 INFO - Using env: {'DISPLAY': ':0', 04:33:51 INFO - 'HOME': '/home/cltbld', 04:33:51 INFO - 'LANG': 'en_US.UTF-8', 04:33:51 INFO - 'LANGUAGE': 'en_US:en', 04:33:51 INFO - 'LOGNAME': 'cltbld', 04:33:51 INFO - 'MAIL': '/var/mail/cltbld', 04:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:51 INFO - 'MOZ_NO_REMOTE': '1', 04:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:51 INFO - 'NO_EM_RESTART': '1', 04:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:51 INFO - 'PWD': '/builds/slave/test', 04:33:51 INFO - 'SHELL': '/bin/bash', 04:33:51 INFO - 'SHLVL': '1', 04:33:51 INFO - 'TERM': 'linux', 04:33:51 INFO - 'TMOUT': '86400', 04:33:51 INFO - 'USER': 'cltbld', 04:33:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:51 INFO - '_': '/tools/buildbot/bin/python'} 04:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:51 INFO - Running setup.py (path:/tmp/pip-BBs7V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:51 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)) 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:51 INFO - Running setup.py (path:/tmp/pip-QkDfLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:51 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)) 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:51 INFO - Running setup.py (path:/tmp/pip-dcVVIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:51 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)) 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:51 INFO - Running setup.py (path:/tmp/pip-9POl6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:51 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)) 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:51 INFO - Running setup.py (path:/tmp/pip-vZyhov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:51 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)) 04:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:51 INFO - Running setup.py (path:/tmp/pip-Lv8G5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:52 INFO - Running setup.py (path:/tmp/pip-sIUdoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:52 INFO - Running setup.py (path:/tmp/pip-a87o6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:52 INFO - Running setup.py (path:/tmp/pip-jMsPeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:52 INFO - Running setup.py (path:/tmp/pip-Mep9H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:52 INFO - Running setup.py (path:/tmp/pip-Y6vpNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:52 INFO - Running setup.py (path:/tmp/pip-v97fqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:52 INFO - Running setup.py (path:/tmp/pip-9qLmZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:52 INFO - Running setup.py (path:/tmp/pip-1_LCDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:52 INFO - Running setup.py (path:/tmp/pip-8FOnmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:52 INFO - Running setup.py (path:/tmp/pip-Z6RZ_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:52 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)) 04:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:52 INFO - Running setup.py (path:/tmp/pip-6JqItl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:52 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)) 04:33:52 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)) 04:33:52 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)) 04:33:52 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)) 04:33:52 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)) 04:33:52 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)) 04:33:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33:54 INFO - Downloading blessings-1.6.tar.gz 04:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:54 INFO - Installing collected packages: blessings 04:33:54 INFO - Running setup.py install for blessings 04:33:54 INFO - Successfully installed blessings 04:33:54 INFO - Cleaning up... 04:33:55 INFO - Return code: 0 04:33:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:55 INFO - Reading from file tmpfile_stdout 04:33:55 INFO - Current package versions: 04:33:55 INFO - argparse == 1.2.1 04:33:55 INFO - blessings == 1.6 04:33:55 INFO - blobuploader == 1.2.4 04:33:55 INFO - docopt == 0.6.1 04:33:55 INFO - functools32 == 3.2.3-2 04:33:55 INFO - jsonschema == 2.5.1 04:33:55 INFO - manifestparser == 1.1 04:33:55 INFO - mozInstall == 1.12 04:33:55 INFO - mozcrash == 0.17 04:33:55 INFO - mozdebug == 0.1 04:33:55 INFO - mozdevice == 0.48 04:33:55 INFO - mozfile == 1.2 04:33:55 INFO - mozhttpd == 0.7 04:33:55 INFO - mozinfo == 0.9 04:33:55 INFO - mozleak == 0.1 04:33:55 INFO - mozlog == 3.2 04:33:55 INFO - moznetwork == 0.27 04:33:55 INFO - mozprocess == 0.22 04:33:55 INFO - mozprofile == 0.28 04:33:55 INFO - mozrunner == 6.11 04:33:55 INFO - mozscreenshot == 0.1 04:33:55 INFO - mozsystemmonitor == 0.3 04:33:55 INFO - moztest == 0.7 04:33:55 INFO - mozversion == 1.4 04:33:55 INFO - psutil == 3.1.1 04:33:55 INFO - requests == 1.2.3 04:33:55 INFO - wsgiref == 0.1.2 04:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:55 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 04:33:55 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 04:33:55 INFO - Using env: {'DISPLAY': ':0', 04:33:55 INFO - 'HOME': '/home/cltbld', 04:33:55 INFO - 'LANG': 'en_US.UTF-8', 04:33:55 INFO - 'LANGUAGE': 'en_US:en', 04:33:55 INFO - 'LOGNAME': 'cltbld', 04:33:55 INFO - 'MAIL': '/var/mail/cltbld', 04:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:55 INFO - 'MOZ_NO_REMOTE': '1', 04:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:55 INFO - 'NO_EM_RESTART': '1', 04:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:55 INFO - 'PWD': '/builds/slave/test', 04:33:55 INFO - 'SHELL': '/bin/bash', 04:33:55 INFO - 'SHLVL': '1', 04:33:55 INFO - 'TERM': 'linux', 04:33:55 INFO - 'TMOUT': '86400', 04:33:55 INFO - 'USER': 'cltbld', 04:33:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:55 INFO - '_': '/tools/buildbot/bin/python'} 04:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 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)) 04:33:55 INFO - Cleaning up... 04:33:55 INFO - Return code: 0 04:33:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:55 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 04:33:55 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 04:33:55 INFO - Using env: {'DISPLAY': ':0', 04:33:55 INFO - 'HOME': '/home/cltbld', 04:33:55 INFO - 'LANG': 'en_US.UTF-8', 04:33:55 INFO - 'LANGUAGE': 'en_US:en', 04:33:55 INFO - 'LOGNAME': 'cltbld', 04:33:55 INFO - 'MAIL': '/var/mail/cltbld', 04:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:55 INFO - 'MOZ_NO_REMOTE': '1', 04:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:55 INFO - 'NO_EM_RESTART': '1', 04:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:55 INFO - 'PWD': '/builds/slave/test', 04:33:55 INFO - 'SHELL': '/bin/bash', 04:33:55 INFO - 'SHLVL': '1', 04:33:55 INFO - 'TERM': 'linux', 04:33:55 INFO - 'TMOUT': '86400', 04:33:55 INFO - 'USER': 'cltbld', 04:33:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:55 INFO - '_': '/tools/buildbot/bin/python'} 04:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:55 INFO - Cleaning up... 04:33:55 INFO - Return code: 0 04:33:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 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 0x7ff54b28ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, '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': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', '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 04:33:55 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 04:33:55 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 04:33:55 INFO - Using env: {'DISPLAY': ':0', 04:33:55 INFO - 'HOME': '/home/cltbld', 04:33:55 INFO - 'LANG': 'en_US.UTF-8', 04:33:55 INFO - 'LANGUAGE': 'en_US:en', 04:33:55 INFO - 'LOGNAME': 'cltbld', 04:33:55 INFO - 'MAIL': '/var/mail/cltbld', 04:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:55 INFO - 'MOZ_NO_REMOTE': '1', 04:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:55 INFO - 'NO_EM_RESTART': '1', 04:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:55 INFO - 'PWD': '/builds/slave/test', 04:33:55 INFO - 'SHELL': '/bin/bash', 04:33:55 INFO - 'SHLVL': '1', 04:33:55 INFO - 'TERM': 'linux', 04:33:55 INFO - 'TMOUT': '86400', 04:33:55 INFO - 'USER': 'cltbld', 04:33:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:55 INFO - '_': '/tools/buildbot/bin/python'} 04:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:55 INFO - Downloading/unpacking flake8 04:33:55 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 04:33:55 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 04:33:55 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 04:33:55 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 04:33:55 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 04:33:55 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 04:33:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:33:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:33:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:33:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:58 INFO - no previously-included directories found matching 'docs/_build' 04:33:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:33:58 INFO - Running setup.py install for pep8 04:33:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:58 INFO - no previously-included directories found matching 'docs/_build' 04:33:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:33:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:33:58 INFO - Cleaning up... 04:33:58 INFO - Return code: 0 04:33:58 INFO - Running post-action listener: _resource_record_post_action 04:33:58 INFO - Running post-action listener: _start_resource_monitoring 04:33:58 INFO - Starting resource monitoring. 04:33:58 INFO - ##### 04:33:58 INFO - ##### Finished create-virtualenv step (success) 04:33:58 INFO - ##### 04:33:58 INFO - ##### 04:33:58 INFO - ##### Running install step. 04:33:58 INFO - ##### 04:33:58 INFO - Running pre-action listener: _resource_record_pre_action 04:33:58 INFO - Running main action method: install 04:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:59 INFO - Reading from file tmpfile_stdout 04:33:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:59 INFO - Reading from file tmpfile_stdout 04:33:59 INFO - Output received: 04:33:59 INFO - Usage: mozinstall [options] installer 04:33:59 INFO - Options: 04:33:59 INFO - -h, --help show this help message and exit 04:33:59 INFO - -d DEST, --destination=DEST 04:33:59 INFO - Directory to install application into. [default: 04:33:59 INFO - "/builds/slave/test"] 04:33:59 INFO - --app=APP Application being installed. [default: firefox] 04:33:59 INFO - mkdir: /builds/slave/test/build/application 04:33:59 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'] 04:33:59 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 04:34:14 INFO - Reading from file tmpfile_stdout 04:34:14 INFO - Output received: 04:34:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:14 INFO - Running post-action listener: _resource_record_post_action 04:34:14 INFO - ##### 04:34:14 INFO - ##### Finished install step (success) 04:34:14 INFO - ##### 04:34:14 INFO - ##### 04:34:14 INFO - ##### Running run-tests step. 04:34:14 INFO - ##### 04:34:14 INFO - Running pre-action listener: _resource_record_pre_action 04:34:14 INFO - Running main action method: run_tests 04:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:14 INFO - Python 2.7.3 04:34:14 INFO - Return code: 0 04:34:14 INFO - grabbing minidump binary from tooltool 04:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:14 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 0x27ff1c0>, '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 0x28000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:14 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 04:34:14 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 04:34:14 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 04:34:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:15 INFO - Return code: 0 04:34:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:34:15 INFO - Return code: 0 04:34:15 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/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:34:15 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/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 04:34:15 INFO - Using env: {'DISPLAY': ':0', 04:34:15 INFO - 'HOME': '/home/cltbld', 04:34:15 INFO - 'LANG': 'en_US.UTF-8', 04:34:15 INFO - 'LANGUAGE': 'en_US:en', 04:34:15 INFO - 'LOGNAME': 'cltbld', 04:34:15 INFO - 'MAIL': '/var/mail/cltbld', 04:34:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:15 INFO - 'MOZ_NO_REMOTE': '1', 04:34:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:15 INFO - 'NO_EM_RESTART': '1', 04:34:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:15 INFO - 'PWD': '/builds/slave/test', 04:34:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:15 INFO - 'SHELL': '/bin/bash', 04:34:15 INFO - 'SHLVL': '1', 04:34:15 INFO - 'TERM': 'linux', 04:34:15 INFO - 'TMOUT': '86400', 04:34:15 INFO - 'USER': 'cltbld', 04:34:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527', 04:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:15 INFO - '_': '/tools/buildbot/bin/python'} 04:34:15 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/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:34:16 INFO - mozversion application_buildid: 20160706164923 04:34:16 INFO - mozversion application_changeset: c1342bdc08a949c74278e59958dbecbc6f138258 04:34:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:34:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:16 INFO - mozversion application_name: Firefox 04:34:16 INFO - mozversion application_remotingname: firefox-dev 04:34:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:16 INFO - mozversion application_vendor: Mozilla 04:34:16 INFO - mozversion application_version: 49.0a2 04:34:16 INFO - mozversion platform_buildid: 20160706164923 04:34:16 INFO - mozversion platform_changeset: c1342bdc08a949c74278e59958dbecbc6f138258 04:34:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:16 INFO - mozversion platform_version: 49.0a2 04:34:16 INFO - using testdate: 1467891256 04:34:16 INFO - actual date: 1467891256 04:34:16 INFO - starting webserver on 'localhost:33793' 04:34:16 INFO - SUITE-START | Running 2 tests 04:34:16 INFO - TEST-START | dromaeo_css 04:34:16 INFO - operating with platform_type : linux_ 04:34:16 INFO - Initialising browser for dromaeo_css test... 04:34:16 INFO - TEST-INFO | started process 3784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptS1RSD/profile http://localhost:33793/getInfo.html) 04:34:20 INFO - PROCESS | 3784 | __metrics Screen width/height:1600/1200 04:34:20 INFO - PROCESS | 3784 | colorDepth:24 04:34:20 INFO - PROCESS | 3784 | Browser inner width/height: 1024/697 04:34:20 INFO - PROCESS | 3784 | __metrics 04:34:20 ERROR - PROCESS | 3784 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:34:21 INFO - TEST-INFO | 3784: exit 0 04:34:21 INFO - Browser initialized. 04:34:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:21 INFO - TEST-INFO | started process 3874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptS1RSD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:33 INFO - PROCESS | 3874 | RSS: Main: 145756160 04:34:33 INFO - PROCESS | 3874 | 04:35:24 INFO - PROCESS | 3874 | 1467891324780 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] 04:37:32 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33793/tests/dromaeo/cssquery-ext.html) 04:37:33 INFO - PROCESS | 3874 | RSS: Main: 248188928 04:37:33 INFO - PROCESS | 3874 | 04:40:36 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-ext.html (next: http://localhost:33793/tests/dromaeo/cssquery-jquery.html) 04:40:36 INFO - PROCESS | 3874 | RSS: Main: 234070016 04:40:36 INFO - PROCESS | 3874 | 04:43:38 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33793/tests/dromaeo/cssquery-mootools.html) 04:43:39 INFO - PROCESS | 3874 | RSS: Main: 227414016 04:43:39 INFO - PROCESS | 3874 | 04:46:41 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33793/tests/dromaeo/cssquery-prototype.html) 04:46:41 INFO - PROCESS | 3874 | RSS: Main: 223330304 04:46:41 INFO - PROCESS | 3874 | 04:49:44 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33793/tests/dromaeo/cssquery-yui.html) 04:49:45 INFO - PROCESS | 3874 | RSS: Main: 217636864 04:49:45 INFO - PROCESS | 3874 | 04:52:47 INFO - PROCESS | 3874 | Cycle 1(1): loaded http://localhost:33793/tests/dromaeo/cssquery-yui.html (next: http://localhost:33793/tests/dromaeo/cssquery-dojo.html) 04:52:48 INFO - PROCESS | 3874 | RSS: Main: 261509120 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | __start_tp_report 04:52:48 INFO - PROCESS | 3874 | _x_x_mozilla_page_load 04:52:48 INFO - PROCESS | 3874 | _x_x_mozilla_page_load_details 04:52:48 INFO - PROCESS | 3874 | |i|pagename|runs| 04:52:48 INFO - PROCESS | 3874 | |0;dojo.html;3331.450310698735;3348.8995330140087;3351.748618853587;3372.072680012998;3392.932141357173;5400.189971504276;5494.587905907063;5511.641743286684;5513.9448605513935;5518.613697041209;5432.782688692448;5528.336599608053;5529.198266251391;5546.77812887485;5564.4991950724425;4927.7536123193695;4989.800407983676;5051.292819005343;5085.872853178663;5118.053160165363;4888.853334399973;5012.573931215833;5057.317262169615;5062.848114556551;5097.108006098936;4985.975070124662;4990.151674215392;5028;5072.568831649314;5074.28959945606;5140.691558506502;5142.434332223453;5155.175171972504;5163.251328557376;5189.6107791915565;4876.902461950741;4928.827491037797;4931.778069986859;5036.320096786923;5060.493950604947;5326.414094449646;5351.7056561889085;5353.57171426285;5356.517913387775;5392.973035134838;5883.882322353529;5895.115732640095;5909.290885093773;5923.881522369572;5925.140854576062;5855.473007429352;5909.113632955048;5913.2608423947;5915.556333275022;6000.489958353545;5546.944530554683;5560.277163968658;5579.107342825128;5583.357913839879;5584.860378490489;5801.6809075500405;6071.878562428727;6073.1497590337385;6075.665838378844;6075.75696972125;5695.316562012585;5728.684922329312;5735.3977832327;5831.650100993954;5833.358330583633;5873.177755114288;5873.941260587425;5874.970625146932;5904.7342869570975;5905.291365036223;5641.153826925994;5730.025895597759;5813.302403711582;5814.447627475383;5851.502622277069;5749.770009199585;5810.1575271586225;5815.476607105381;5818.854528636733;5859.882802343929;4504.189245935698;4509.864704058883;4513.864584062483;4516.525764794715;4539.046800171935;3995.5405128410025;4002.799860006988;4031.032552187454;4045.2314060328445;4080.0207950091763;5539.362973258127;5562.582806289544;5563.527100196528;5565.693886836263;5598.076317407664;5928.555358348141;5938.317093534212;5940.257467816523;5943.138244954457;5962;5336.7865285388925;5523.116301391758;5547.472990065938;5561.582881283839;5567.220589117445;5006.349174607278;5048.495150484922;5050.823221187241;5073.568746656501;5079.212722028092;6131.172291740647;6142.201513803267;6147.538934579835;6154.5076393888385;6156.661383623854;5677;5772.393898640582;5818.970905145447;5832.766689332379;5891.675957822361;6093.969530152321;6094.9085763714465;6099;6101.237345331833;6107.389261073857;5743.942560574508;5746.5402767779315;5754.395788442153;5761.193432919311;5765.279340082489;5698.54411647059;5817.709114544171;5858.150568167677;5890.204822348928;5964.135200395832;5753.971230143822;5784.7107644618445;5785.4214578541805;5785.508231800344;5790;5721.22763426932;5760.481556659921;5773.249477568057;5773.393793651606;5786.508146807569;5488.4785945335125;5590.161475778666;5628.521575666115;5643.181738647955;5696.487316141567;5755.827325180251;5800.303963524404;5801.8549536261935;5808.099744539603;5808.593398462067;5487.64330318528;5661.433856614306;5665.178549110438;5665.348484924287;5665.745041473226 04:52:48 INFO - PROCESS | 3874 | |1;ext.html;601.9789307374243;656.0683828962873;657.3196741372681;667.8530723240887;675.0347003784586;33463.16342091446;36291.45562816557;45069;45881.311780323325;46038.53961460385;47641.523584764145;47957.28064079041;47987;48110.518894811044;48157.7592112039;9094.499802510876;9240.491772952484;9255.768605784842;9262.583183756713;9263.212626926686;8346.87479687802;10731.946340268327;10951.780964380707;10955.616553420632;11320.943395283053;11071.446427678584;11126.38804865732;11146.6098686546;11155.609553665623;11155.776884462306;8573;8846.557672116433;11000.614978475754;11069.667909962714;11074.501647425845;10667.573297068107;11068.225224234307;11071.391073490955;11082.556697732161;11480.942595287053;41359.58640413587;41918.790406047774;46398.5360146401;46581.30128048082;46663.30005049927;3615.837287322077;4165.271077561415;4483.170613436525;4508.752018638974;4561.087782443525;35136.82431587826;35690.28619427623;35975.82012089949;36029.639703602894;36121.45817812735;4079.224947260011;4166.062635906927;4176.600838719033;4194.538600753915;4269.466316710411;396833;396993;397919;398509;399599;68767.31232687709;69328;69404;69630.30369696238;69758;40727.389089163684;41652.791736041734;41699.1660166801;43622.781886090364;44002.33996490055;19918.402447926586;19959;20098.69851952222;20101.49746256326;20121.899390502953;12497.25016499013;14799.778003329959;15103.169325687193;15190.696186076217;15302.770458443132;22861.19985800489;23123.537529249657;23215.767842321362;23228.257880659017;23275.650865237036;7797.7660670179985;7929.167437419103;8154.429189956646;8158.184181581794;8363.16368363171;1002.588938535197;1010.6260683547134;1066.9970227985668;1144.3248483394837;1171.226990186473;34566.82716586401;35391;35464.82267588697;35537.64462355343;35619.28761424809;1143.3882872663085;1242.099477878531;1280.11032332528;1302.6482849630736;1341.6511706956262;18350.81649183518;18372.35696750607;18523.166457509444;18636.627267454576;18695.626087478173;560930;564119;566007;567721;568589;66201.66899165473;66841;66872.66563667248;66918.66540667265;66938.66530667413;1273.0770191611007;1302.4790083966489;1383.2115694054494;1412.3856122586503;1419.3754747910887;32016.51975220327;35655.82172089123;36097.81951090228;36443.63556364403;36668;54549.72725136349;55158.448415516934;55197;55270;55278.170827436814;420621;421791;421974;422144;422889;27457.17628471149;27891.860540697977;27964.720352796212;28038.43923121567;28162.718372816827;51370.48629513657;52309.7384513075;52651.73674131758;53183.20225196548;53406;43919.290645863475;44677;45017.774911125234;45074.32388514109;46711.29933051075;43069;43344.78327608342;43446.34830477482;44209;44549;44711;45056;45416;45423.318650220936;45639.087218256114;38474.807625961694;38713.61286387213;39766;40312.59687403088;40341.39487907742;28765.568516471852;29251.85374073201;29291.560626591043;29411.705882940896;29596 04:52:48 INFO - PROCESS | 3874 | |2;jquery.html;420.59622762148337;430.91381723655275;433.93318214394424;436.08639899410736;436.1973967899065;19047.52381190469;20107.497312567193;20778.89610551947;21114.788852111513;21145.471363215926;19727.309544165957;20098.397048088544;20312.28906988252;20315.695264571044;20390.286339978065;5592.804251851186;5825.155352473888;5862.70686465675;5867.530597552207;5875.294964604253;5751.712414379264;5752.65484070955;5756.654600723949;5761.078227483604;5805.535557155417;5688.146777983315;5688.459596338341;5690.5447564194765;5696.231008813798;5719.370869204384;5672.943270567303;7185.928140718578;7598.886016709754;7618.542887426716;7619.504732192418;7173.210946795848;7375.926240737577;7401.037865077506;7522.247775222489;7532.736354227576;27542.311442214104;27969;28162.43675126486;28794.712052879622;28795.712042879513;2489.3154382544762;2503.4492411669403;2530.000649743341;2533;2639.1158961747838;15631;16472.752908706378;16674.666506669797;16779.66440671192;17283.222254998556;2203.22886989554;2206.6800313954386;2207.834412419075;2221.8777967211795;2230.174835310945;100409.49795250977;100543.49728251385;104672;105024.4748776259;105195;18799.718004229948;19032.809671903382;19227.80772192288;19461.12424940881;19528.804711952984;34415.82792086023;34897.30205395878;34987.125321867155;35300;35453.64546354555;10740.140788736882;10934.781304373868;10938.398388088732;11008.174386921013;11532.654020379403;9012.233960113464;9027.954860225656;9059.81880362389;9163.404378715362;9537.189338906272;9835.754106147404;9879.851802222973;9889.20886329092;9891.851622225673;9987.800243995225;3566.9108272292883;3637.308911306843;3738.43923411485;3750.456183853326;3822.3502004659276;949.4493193947494;950.5247376311844;995.8406654935176;1021.4688362051841;1026.9435181064964;19853.404397868086;20245;20259.79740202579;20428.48928776763;20477.180912763324;995.571904081252;999.2655398282257;1008.5209525475341;1012.2661070723666;1053.378506681062;10936.890631093587;11297.343173798039;11337.659870203906;11440.199186056896;11541.769164616828;585022;585200;612340;615159;626162.8691856512;99099;103681;103956.48021759842;104897.80408783715;105894.47052764687;1086.9456527173609;1105.546725842417;1119.6585041562403;1124.3197865291545;1129.8983091521802;17690.646187076443;17742.379016734354;18013.819861801214;18469.261229550666;18723.71914421312;42922.35616465818;43000.354994675734;43841.78079109584;43854.34218486661;44170;58502.41497584969;59289.40710593011;60421.39578604334;60887.69556152191;62425;8949.731508054769;9069.555392574584;9160.267178625827;9211.539423028957;9389.436633801994;13190.868091318964;13434.05961582719;13532.120412173177;13669.111507751964;13823.585292441243;11700.857050048793;11704.94147529257;11820.76358472843;11975.461104250155;12078.51685932588;12002.75994480088;12022.729637207587;12033.097517686383;12172.391380430767;12363.32001739877;12043.75912481728;12164.939175304067;12180.330081845583;12262.816057758962;12263.26420414778;8101.432899696964;8905.777355565904;9009.684661037094;9090.409123407222;9112.77218069527;11837.585684501;12438.813417798921;12528.749425011267;12628.43172057278;12644.620661380173 04:52:48 INFO - PROCESS | 3874 | |3;mootools.html;1413.2227274998747;1583.1530131379711;1607.6141725985763;1780.5904641932354;1902.5814320849408;9206.907930920688;9344.06559344066;9347.859782103265;9819.509024548779;9851.802963940718;9560.713178604654;9776.511174441284;9779.511024448768;9789.657361992331;9792.951035244832;2204.7464541577683;2443.841150325223;2498.5502609530367;2504.298796337024;2539.5301869154173;2541.0344069253656;2549.7195308516048;2551.4897020595863;2553.6807899012624;2555.0674003988597;2479.764422379871;2524.7222805491383;2532.151729170721;2536.759007894247;2540.618907163922;2165.3828658832235;2224.410531209239;2407.843490173133;2411.7467665895006;2465.050955382173;2494.4761600064007;2502;2514.0446630280376;2518.382996165951;2519.571672815626;9647.758806029835;9697.127258546694;9702.078302561245;9706.223502119814;9709.514524273829;5564.10974244119;5687.289088863892;5694.117411801136;5700;5704.401037891003;3566.233259849119;3607.693346065588;3659.9085022874374;3686.6129056448954;3767.190054138346;1151.4875880233299;1153.6250718516517;1155.3587758793867;1199.8200269959489;1251.943662535179;13226.86773132266;13238.404271807793;13261.801072983913;13271.800922986067;13287.800682989762;4991.176455884738;4992.525710057539;5009.398872135294;5022.171341728647;5068.113080210948;10942.890571094347;10990.890091099147;11005.119590432747;11024;11033;5660.2075709400715;5669.319681638147;5678.630888992202;5686.175504551899;5687.630304030225;4524.25349817283;5126.53861152498;5164.122099243063;5189.247559103909;5341.198820177005;4354.107407981356;4361.629261512743;4427.867163985085;4455.376247325377;4466.843660471868;1363.9181649101085;1393.909395889264;1403.8876889848787;1408.190290582919;1413.1168019987508;993.3890657245886;1000.229823036258;1000.9849852252222;1008.077608987768;1010.5755582655303;6103.725332360054;6149.0776383542825;6231.781887634002;6293.276273228637;6331.398517140864;483.29439019032606;487.8560824556764;494.5969035236271;505.6207844116912;511.8515630467197;4073.4166922825;4126.484189476316;4151.211269858717;4164.479440069991;4230.111676547898;11905.404729763477;12276.631701048982;12367.93816030932;12377.195482293622;12387.256764594153;12147.331896745587;12258.877411225774;12268.202566833128;12273.570425035081;12282.078844086729;8457.154284571494;8467.49195048299;8535.274501667303;8930.464172149563;9035.593398297093;6199.845003874939;6305.779297724557;6390.5526613136635;6409.743610255724;6504.991726282434;10736.409497477714;10775.191860610643;11284.661460156209;11377.317360958368;11391.772164556496;11243.494042767932;11334.149938754792;11351.829722554334;11357.602483913024;11476.770464590494;7593.240675932362;7641.961790191013;8204.630791614272;8422.95788521078;8603.053664096818;8999.820003600022;9537.046295370408;9559.713208603753;9593.664221752206;9611.375260608038;8374.623141958748;8443.493390396596;8578.227959483676;8615.569221538773;8625.137486251324;8219.83560328802;8255.25702686761;8338.62476188585;8476.872846907425;8564.229219370287;7107.076080109553;7161.4270858330165;7166.784996450115;7480.0649918760155;7482.289182527651;5365.356157261153;5456.345238571397;5554.1391084381985;5662.2639056922335;5700.686462244616;5287.709175995357;5306.734663266744;5445.156000819879;5453.072977593739;5473.343198816167 04:52:48 INFO - PROCESS | 3874 | |4;prototype.html;326.59176029962543;329.3035230487518;336.5809567088975;340.1156991821263;341.78979927344693;5357.571394288452;5383.515483606475;5406.621536492442;5429.809956651518;5481.479259470354;5102.5252752415045;5138;5340.49265319795;5391.514763671269;5414.512693857552;4202.600752928467;4211.978940105295;4244.915101697964;4250.341197114452;4268.423762792022;4250.53244143144;4259.1268789897995;4262.616364527192;4269.274223382017;4279.807408666617;4016.9799151004204;4088.6081642239324;4198.8320467181275;4206.284931561627;4225.323948168294;4163.10493243954;4191.580841915815;4197.538270790211;4211.326187809951;4213.747175169485;3745.62543745626;3750.1749615084636;3764.4353346997896;3767.6232376762377;3777.2067865748227;5197.272381866542;5205.609579281569;5206.114960456694;5230.137027390476;5339.225812257201;4841;4848.10310092634;4859.271109333593;4864.489228630978;4883.096627123993;5590.524805391506;5645.407232240637;5667.744951477152;5674.914876276859;5726.856828579277;4055.5538890721996;4186.5604111568155;4205.11692544566;4207.537170911197;4215.957840421618;5871.4128587141795;5878.941210587882;5895.644001879549;5905.822825315247;5920.141579470953;4267.146570685875;4269.7224680395675;4270.807813648394;4301.2257793597455;4305.880471077542;4211.810468528924;4219.6202341789385;4235.322348424299;4239.42767726353;4253.085586598834;4798.592119669867;4803.351547541107;4808.3027960945465;4842.176829938919;4844.588210002189;5629.453444330046;5632.211490391349;5642.871425714873;5651.208830763697;5655.3779084300695;1423.4306277489088;1434.2398528779763;1449.0870751426744;1506.517914267424;1513.9621509462352;945.4799860077068;955.6811599991967;960.9807803843884;963.7927845513249;974.0065133563726;4872.171730805771;4884.658073934862;4912.582430493448;4916.926246106311;4961.950380496221;5108.591312694975;5135.666181698178;5167.974160129251;5168.457311982188;5183.97408012965;4846.636502262344;4862.80548778052;4909.607231421478;4963.677360971526;5150.381954165524;3113.517404802259;3133.81197128173;3150.7951983121025;3168.9859245041366;3173.222560472699;6116.541259405562;6153.815385538441;6167.136600875881;6177.2587289525545;6191.783287584913;5850.3564607893095;5862.70686465675;5873.530117590668;5881.852953676107;5905.970470147622;6082.080601311395;6083.178770866053;6083.695815209222;6090.847728806815;6094.238220222473;5595.216669666332;5803.564732644984;5829.7085145743395;5833.716582351876;5856.238688970407;5776.7111644418455;5814.883702326015;5827.94172058274;5836.9493491172;5837.6497410155525;6118.449339559461;6137.294211165595;6140.048292514667;6152.723127459186;6185.165002724754;3941.60583941615;4107.89730256734;4113.91772164561;4137.731047481904;4153.605407486284;5625.690587017753;5780.21967034445;5781.277340332458;5811.244538210006;5817.650940943557;5629.746661400329;5681.9147712783515;5705.828825135252;5732.656040637575;5749.993751093458;5606.327240730975;5674.716264186856;5685.204071430086;5695.45893140151;5716.685582293014;5346.572274217975;5532.972335138459;5598.824246908032;5658.462446067617;5682.403347648603;5673.631213971079;5715.428457154251;5745.942540574708;5773.364929857628;5774.711264436845;5501.642393244426;5587.189857470726;5593.664380137205;5603.663780173202;5620.803271885465 04:52:48 INFO - PROCESS | 3874 | |5;yui.html;796.4345314826473;815.465869855245;842.7345386203342;850.5152063323906;902.584810986946;16490.42283520077;16522.42171523997;17095.14524273786;17176.828231717678;17343.479695609152;15830.76253856193;15864.28610712518;15961.600959975978;15992.600184995352;15993.84006159938;728.2971932085536;848.974530764075;859.4284800607588;859.7764581208884;870.9390342676015;879.6701237036111;880.9691660791874;881.497546398553;887.3921363865741;890.1143362354467;925.1165137293868;925.6112432778216;926.6386109417333;926.9165775080241;927.2952556057378;762.8169239382536;779.5244900610651;890.2210565754964;915.0666320353268;920.3327587499043;686.4954258619911;686.5125760709902;686.5160062156168;686.5297271369128;687.2577616174569;15539;15563.844361556467;15615.531534053996;15619.531414057596;15621.062736235863;15307.158106304149;15309.923450382788;15399.384024639001;15469.303881325368;15624.296906639229;13095.279759613217;13103.410346534429;13253.602391928258;13291.468341266338;13341.466341346335;4750.833720819789;4756.500567440404;4803.063402636487;4810.7113573185725;4887.242477416006;73981;78263.21736782616;78696.21303786946;79084.60457697732;79793.20206797974;11434.142439317084;11726.651435085074;11957.940210298893;12091.214071085351;12698.873011269954;21417.46456338573;21453.570928581343;21461.03425345863;21465.89267053686;21494;9023.593938272794;9070.682526111686;9310.115539023782;9464.95267523658;9483.573239204114;4968.478309777493;5151.639385243072;5164.1995490699;5194.818181363709;5280.9207861882105;3700.500432441586;3812.5806161322234;3813.84744610218;3818.7899665518107;3819.4461803038403;484.6946423753084;677.8034370032635;682.3619915379137;682.6313790553145;683.4976292425064;705.6260182103493;785.1089013969072;786.9331106855867;789.214731342318;824.6289169873581;10370.844437333446;10551.94724026375;10627.574897004188;10735.355878647306;11251.156163287622;795.8965334506477;805.3476683886071;823.9629216685264;833.1044127562773;835.6156168162591;5062.443131255559;5065.265536497187;5095.515925987025;5121.359830021247;5123.2827404163445;124461.75538244683;126943;127283.27225274885;129661;130402.34798826135;107815.46092269645;109448;110201;111782;112500.43749781199;93537.53231233801;94631.52684236535;95170;95375;95603.52198239103;9678.322517423712;9696.0788725071;9794.510274486389;9841.212702983601;9853.458059806779;56551.71724141353;57304.14043789263;57723;58725.412745871996;61598.38401615927;67453.66273168602;68418;79585;86679;87253.56373218093;12119.575814846437;13909.165450073027;14245.145291282557;14475.131492110086;14709.190994494977;14057.367418465989;14655.047421917541;14686;15754.369825206863;16369.590760231089;14023.649408764863;15390.153541555323;15405.416153020169;15751.44869929547;15906.52280431589;14706.19115948633;15394.15332156742;15524.379024839332;15702.057876527444;15920.601984950468;14818.40726370933;15173.620659483602;15286.770698439756;15413;15754.76367854506;11685.824712629148;11712.414379280832;11843.58547450835;11907.404629768303;12482.687932801753;11865.169438139248;11907.642770716893;12013.579524716593;12161.209521381083;12333.260004399765 04:52:48 INFO - PROCESS | 3874 | __end_tp_report 04:52:48 INFO - PROCESS | 3874 | __start_cc_report 04:52:48 INFO - PROCESS | 3874 | _x_x_mozilla_cycle_collect,828 04:52:48 INFO - PROCESS | 3874 | __end_cc_report 04:52:48 INFO - PROCESS | 3874 | __startTimestamp1467892368024__endTimestamp 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | ------- Summary: start ------- 04:52:48 INFO - PROCESS | 3874 | Number of tests: 6 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#0] dojo.html Cycles:165 Average:5467.33 Median:5665.18 stddev:593.63 (10.5%) stddev-sans-first:571.31 04:52:48 INFO - PROCESS | 3874 | Values: 3331.5 3348.9 3351.7 3372.1 3392.9 5400.2 5494.6 5511.6 5513.9 5518.6 5432.8 5528.3 5529.2 5546.8 5564.5 4927.8 4989.8 5051.3 5085.9 5118.1 4888.9 5012.6 5057.3 5062.8 5097.1 4986.0 4990.2 5028.0 5072.6 5074.3 5140.7 5142.4 5155.2 5163.3 5189.6 4876.9 4928.8 4931.8 5036.3 5060.5 5326.4 5351.7 5353.6 5356.5 5393.0 5883.9 5895.1 5909.3 5923.9 5925.1 5855.5 5909.1 5913.3 5915.6 6000.5 5546.9 5560.3 5579.1 5583.4 5584.9 5801.7 6071.9 6073.1 6075.7 6075.8 5695.3 5728.7 5735.4 5831.7 5833.4 5873.2 5873.9 5875.0 5904.7 5905.3 5641.2 5730.0 5813.3 5814.4 5851.5 5749.8 5810.2 5815.5 5818.9 5859.9 4504.2 4509.9 4513.9 4516.5 4539.0 3995.5 4002.8 4031.0 4045.2 4080.0 5539.4 5562.6 5563.5 5565.7 5598.1 5928.6 5938.3 5940.3 5943.1 5962.0 5336.8 5523.1 5547.5 5561.6 5567.2 5006.3 5048.5 5050.8 5073.6 5079.2 6131.2 6142.2 6147.5 6154.5 6156.7 5677.0 5772.4 5819.0 5832.8 5891.7 6094.0 6094.9 6099.0 6101.2 6107.4 5743.9 5746.5 5754.4 5761.2 5765.3 5698.5 5817.7 5858.2 5890.2 5964.1 5754.0 5784.7 5785.4 5785.5 5790.0 5721.2 5760.5 5773.2 5773.4 5786.5 5488.5 5590.2 5628.5 5643.2 5696.5 5755.8 5800.3 5801.9 5808.1 5808.6 5487.6 5661.4 5665.2 5665.3 5665.7 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#1] ext.html Cycles:180 Average:63659.90 Median:22403.31 stddev:123751.80 (552.4%) stddev-sans-first:124008.39 04:52:48 INFO - PROCESS | 3874 | Values: 602.0 656.1 657.3 667.9 675.0 33463.2 36291.5 45069.0 45881.3 46038.5 47641.5 47957.3 47987.0 48110.5 48157.8 9094.5 9240.5 9255.8 9262.6 9263.2 8346.9 10731.9 10951.8 10955.6 11320.9 11071.4 11126.4 11146.6 11155.6 11155.8 8573.0 8846.6 11000.6 11069.7 11074.5 10667.6 11068.2 11071.4 11082.6 11480.9 41359.6 41918.8 46398.5 46581.3 46663.3 3615.8 4165.3 4483.2 4508.8 4561.1 35136.8 35690.3 35975.8 36029.6 36121.5 4079.2 4166.1 4176.6 4194.5 4269.5 396833.0 396993.0 397919.0 398509.0 399599.0 68767.3 69328.0 69404.0 69630.3 69758.0 40727.4 41652.8 41699.2 43622.8 44002.3 19918.4 19959.0 20098.7 20101.5 20121.9 12497.3 14799.8 15103.2 15190.7 15302.8 22861.2 23123.5 23215.8 23228.3 23275.7 7797.8 7929.2 8154.4 8158.2 8363.2 1002.6 1010.6 1067.0 1144.3 1171.2 34566.8 35391.0 35464.8 35537.6 35619.3 1143.4 1242.1 1280.1 1302.6 1341.7 18350.8 18372.4 18523.2 18636.6 18695.6 560930.0 564119.0 566007.0 567721.0 568589.0 66201.7 66841.0 66872.7 66918.7 66938.7 1273.1 1302.5 1383.2 1412.4 1419.4 32016.5 35655.8 36097.8 36443.6 36668.0 54549.7 55158.4 55197.0 55270.0 55278.2 420621.0 421791.0 421974.0 422144.0 422889.0 27457.2 27891.9 27964.7 28038.4 28162.7 51370.5 52309.7 52651.7 53183.2 53406.0 43919.3 44677.0 45017.8 45074.3 46711.3 43069.0 43344.8 43446.3 44209.0 44549.0 44711.0 45056.0 45416.0 45423.3 45639.1 38474.8 38713.6 39766.0 40312.6 40341.4 28765.6 29251.9 29291.6 29411.7 29596.0 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#2] jquery.html Cycles:180 Average:34962.71 Median:2516.72 stddev:99547.23 (3955.4%) stddev-sans-first:99792.69 04:52:48 INFO - PROCESS | 3874 | Values: 420.6 430.9 433.9 436.1 436.2 19047.5 20107.5 20778.9 21114.8 21145.5 19727.3 20098.4 20312.3 20315.7 20390.3 5592.8 5825.2 5862.7 5867.5 5875.3 5751.7 5752.7 5756.7 5761.1 5805.5 5688.1 5688.5 5690.5 5696.2 5719.4 5672.9 7185.9 7598.9 7618.5 7619.5 7173.2 7375.9 7401.0 7522.2 7532.7 27542.3 27969.0 28162.4 28794.7 28795.7 2489.3 2503.4 2530.0 2533.0 2639.1 15631.0 16472.8 16674.7 16779.7 17283.2 2203.2 2206.7 2207.8 2221.9 2230.2 100409.5 100543.5 104672.0 105024.5 105195.0 18799.7 19032.8 19227.8 19461.1 19528.8 34415.8 34897.3 34987.1 35300.0 35453.6 10740.1 10934.8 10938.4 11008.2 11532.7 9012.2 9028.0 9059.8 9163.4 9537.2 9835.8 9879.9 9889.2 9891.9 9987.8 3566.9 3637.3 3738.4 3750.5 3822.4 949.4 950.5 995.8 1021.5 1026.9 19853.4 20245.0 20259.8 20428.5 20477.2 995.6 999.3 1008.5 1012.3 1053.4 10936.9 11297.3 11337.7 11440.2 11541.8 585022.0 585200.0 612340.0 615159.0 626162.9 99099.0 103681.0 103956.5 104897.8 105894.5 1086.9 1105.5 1119.7 1124.3 1129.9 17690.6 17742.4 18013.8 18469.3 18723.7 42922.4 43000.4 43841.8 43854.3 44170.0 58502.4 59289.4 60421.4 60887.7 62425.0 8949.7 9069.6 9160.3 9211.5 9389.4 13190.9 13434.1 13532.1 13669.1 13823.6 11700.9 11704.9 11820.8 11975.5 12078.5 12002.8 12022.7 12033.1 12172.4 12363.3 12043.8 12164.9 12180.3 12262.8 12263.3 8101.4 8905.8 9009.7 9090.4 9112.8 11837.6 12438.8 12528.7 12628.4 12644.6 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#3] mootools.html Cycles:180 Average:6273.97 Median:485.58 stddev:3665.31 (754.8%) stddev-sans-first:3657.39 04:52:48 INFO - PROCESS | 3874 | Values: 1413.2 1583.2 1607.6 1780.6 1902.6 9206.9 9344.1 9347.9 9819.5 9851.8 9560.7 9776.5 9779.5 9789.7 9793.0 2204.7 2443.8 2498.6 2504.3 2539.5 2541.0 2549.7 2551.5 2553.7 2555.1 2479.8 2524.7 2532.2 2536.8 2540.6 2165.4 2224.4 2407.8 2411.7 2465.1 2494.5 2502.0 2514.0 2518.4 2519.6 9647.8 9697.1 9702.1 9706.2 9709.5 5564.1 5687.3 5694.1 5700.0 5704.4 3566.2 3607.7 3659.9 3686.6 3767.2 1151.5 1153.6 1155.4 1199.8 1251.9 13226.9 13238.4 13261.8 13271.8 13287.8 4991.2 4992.5 5009.4 5022.2 5068.1 10942.9 10990.9 11005.1 11024.0 11033.0 5660.2 5669.3 5678.6 5686.2 5687.6 4524.3 5126.5 5164.1 5189.2 5341.2 4354.1 4361.6 4427.9 4455.4 4466.8 1363.9 1393.9 1403.9 1408.2 1413.1 993.4 1000.2 1001.0 1008.1 1010.6 6103.7 6149.1 6231.8 6293.3 6331.4 483.3 487.9 494.6 505.6 511.9 4073.4 4126.5 4151.2 4164.5 4230.1 11905.4 12276.6 12367.9 12377.2 12387.3 12147.3 12258.9 12268.2 12273.6 12282.1 8457.2 8467.5 8535.3 8930.5 9035.6 6199.8 6305.8 6390.6 6409.7 6505.0 10736.4 10775.2 11284.7 11377.3 11391.8 11243.5 11334.1 11351.8 11357.6 11476.8 7593.2 7642.0 8204.6 8423.0 8603.1 8999.8 9537.0 9559.7 9593.7 9611.4 8374.6 8443.5 8578.2 8615.6 8625.1 8219.8 8255.3 8338.6 8476.9 8564.2 7107.1 7161.4 7166.8 7480.1 7482.3 5365.4 5456.3 5554.1 5662.3 5700.7 5287.7 5306.7 5445.2 5453.1 5473.3 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#4] prototype.html Cycles:180 Average:4749.87 Median:5284.68 stddev:1389.90 (26.3%) stddev-sans-first:1353.57 04:52:48 INFO - PROCESS | 3874 | Values: 326.6 329.3 336.6 340.1 341.8 5357.6 5383.5 5406.6 5429.8 5481.5 5102.5 5138.0 5340.5 5391.5 5414.5 4202.6 4212.0 4244.9 4250.3 4268.4 4250.5 4259.1 4262.6 4269.3 4279.8 4017.0 4088.6 4198.8 4206.3 4225.3 4163.1 4191.6 4197.5 4211.3 4213.7 3745.6 3750.2 3764.4 3767.6 3777.2 5197.3 5205.6 5206.1 5230.1 5339.2 4841.0 4848.1 4859.3 4864.5 4883.1 5590.5 5645.4 5667.7 5674.9 5726.9 4055.6 4186.6 4205.1 4207.5 4216.0 5871.4 5878.9 5895.6 5905.8 5920.1 4267.1 4269.7 4270.8 4301.2 4305.9 4211.8 4219.6 4235.3 4239.4 4253.1 4798.6 4803.4 4808.3 4842.2 4844.6 5629.5 5632.2 5642.9 5651.2 5655.4 1423.4 1434.2 1449.1 1506.5 1514.0 945.5 955.7 961.0 963.8 974.0 4872.2 4884.7 4912.6 4916.9 4962.0 5108.6 5135.7 5168.0 5168.5 5184.0 4846.6 4862.8 4909.6 4963.7 5150.4 3113.5 3133.8 3150.8 3169.0 3173.2 6116.5 6153.8 6167.1 6177.3 6191.8 5850.4 5862.7 5873.5 5881.9 5906.0 6082.1 6083.2 6083.7 6090.8 6094.2 5595.2 5803.6 5829.7 5833.7 5856.2 5776.7 5814.9 5827.9 5836.9 5837.6 6118.4 6137.3 6140.0 6152.7 6185.2 3941.6 4107.9 4113.9 4137.7 4153.6 5625.7 5780.2 5781.3 5811.2 5817.7 5629.7 5681.9 5705.8 5732.7 5750.0 5606.3 5674.7 5685.2 5695.5 5716.7 5346.6 5533.0 5598.8 5658.5 5682.4 5673.6 5715.4 5745.9 5773.4 5774.7 5501.6 5587.2 5593.7 5603.7 5620.8 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - PROCESS | 3874 | [#5] yui.html Cycles:180 Average:22571.64 Median:4753.67 stddev:32752.98 (689.0%) stddev-sans-first:32804.05 04:52:48 INFO - PROCESS | 3874 | Values: 796.4 815.5 842.7 850.5 902.6 16490.4 16522.4 17095.1 17176.8 17343.5 15830.8 15864.3 15961.6 15992.6 15993.8 728.3 849.0 859.4 859.8 870.9 879.7 881.0 881.5 887.4 890.1 925.1 925.6 926.6 926.9 927.3 762.8 779.5 890.2 915.1 920.3 686.5 686.5 686.5 686.5 687.3 15539.0 15563.8 15615.5 15619.5 15621.1 15307.2 15309.9 15399.4 15469.3 15624.3 13095.3 13103.4 13253.6 13291.5 13341.5 4750.8 4756.5 4803.1 4810.7 4887.2 73981.0 78263.2 78696.2 79084.6 79793.2 11434.1 11726.7 11957.9 12091.2 12698.9 21417.5 21453.6 21461.0 21465.9 21494.0 9023.6 9070.7 9310.1 9465.0 9483.6 4968.5 5151.6 5164.2 5194.8 5280.9 3700.5 3812.6 3813.8 3818.8 3819.4 484.7 677.8 682.4 682.6 683.5 705.6 785.1 786.9 789.2 824.6 10370.8 10551.9 10627.6 10735.4 11251.2 795.9 805.3 824.0 833.1 835.6 5062.4 5065.3 5095.5 5121.4 5123.3 124461.8 126943.0 127283.3 129661.0 130402.3 107815.5 109448.0 110201.0 111782.0 112500.4 93537.5 94631.5 95170.0 95375.0 95603.5 9678.3 9696.1 9794.5 9841.2 9853.5 56551.7 57304.1 57723.0 58725.4 61598.4 67453.7 68418.0 79585.0 86679.0 87253.6 12119.6 13909.2 14245.1 14475.1 14709.2 14057.4 14655.0 14686.0 15754.4 16369.6 14023.6 15390.2 15405.4 15751.4 15906.5 14706.2 15394.2 15524.4 15702.1 15920.6 14818.4 15173.6 15286.8 15413.0 15754.8 11685.8 11712.4 11843.6 11907.4 12482.7 11865.2 11907.6 12013.6 12161.2 12333.3 04:52:48 INFO - PROCESS | 3874 | -------- Summary: end -------- 04:52:48 INFO - PROCESS | 3874 | 04:52:48 INFO - TEST-INFO | 3874: exit 0 04:52:48 INFO - TEST-OK | dromaeo_css | took 1112525ms 04:52:48 INFO - TEST-START | kraken 04:52:48 INFO - operating with platform_type : linux_ 04:52:48 INFO - Initialising browser for kraken test... 04:52:48 INFO - TEST-INFO | started process 4068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwjU8R/profile http://localhost:33793/getInfo.html) 04:52:52 INFO - PROCESS | 4068 | __metrics Screen width/height:1600/1200 04:52:52 INFO - PROCESS | 4068 | colorDepth:24 04:52:52 INFO - PROCESS | 4068 | Browser inner width/height: 1024/697 04:52:52 INFO - PROCESS | 4068 | __metrics 04:52:53 ERROR - PROCESS | 4068 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:52:54 INFO - TEST-INFO | 4068: exit 0 04:52:54 INFO - Browser initialized. 04:52:54 INFO - Running cycle 1/1 for kraken test... 04:52:54 INFO - TEST-INFO | started process 4157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwjU8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:06 INFO - PROCESS | 4157 | RSS: Main: 145502208 04:53:06 INFO - PROCESS | 4157 | 04:53:08 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33793/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:09 INFO - PROCESS | 4157 | RSS: Main: 194523136 04:53:09 INFO - PROCESS | 4157 | 04:53:11 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33793/tests/kraken/driver.html?testName=audio-dft) 04:53:12 INFO - PROCESS | 4157 | RSS: Main: 192909312 04:53:12 INFO - PROCESS | 4157 | 04:53:15 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33793/tests/kraken/driver.html?testName=audio-fft) 04:53:15 INFO - PROCESS | 4157 | RSS: Main: 278769664 04:53:15 INFO - PROCESS | 4157 | 04:53:18 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33793/tests/kraken/driver.html?testName=audio-oscillator) 04:53:18 INFO - PROCESS | 4157 | RSS: Main: 187809792 04:53:18 INFO - PROCESS | 4157 | 04:53:20 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:21 INFO - PROCESS | 4157 | RSS: Main: 188313600 04:53:21 INFO - PROCESS | 4157 | 04:53:24 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33793/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:24 INFO - PROCESS | 4157 | RSS: Main: 223055872 04:53:24 INFO - PROCESS | 4157 | 04:53:28 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33793/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:28 INFO - PROCESS | 4157 | RSS: Main: 223825920 04:53:28 INFO - PROCESS | 4157 | 04:53:31 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33793/tests/kraken/driver.html?testName=json-parse-financial) 04:53:32 INFO - PROCESS | 4157 | RSS: Main: 223551488 04:53:32 INFO - PROCESS | 4157 | 04:53:33 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:34 INFO - PROCESS | 4157 | RSS: Main: 201338880 04:53:34 INFO - PROCESS | 4157 | 04:53:36 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:36 INFO - PROCESS | 4157 | RSS: Main: 203149312 04:53:36 INFO - PROCESS | 4157 | 04:53:38 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:39 INFO - PROCESS | 4157 | RSS: Main: 208904192 04:53:39 INFO - PROCESS | 4157 | 04:53:41 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:42 INFO - PROCESS | 4157 | RSS: Main: 211968000 04:53:42 INFO - PROCESS | 4157 | 04:53:45 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:45 INFO - PROCESS | 4157 | RSS: Main: 212295680 04:53:45 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | Cycle 1(1): loaded http://localhost:33793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33793/tests/kraken/driver.html?testName=ai-astar) 04:53:47 INFO - PROCESS | 4157 | RSS: Main: 254955520 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | __start_tp_report 04:53:47 INFO - PROCESS | 4157 | _x_x_mozilla_page_load 04:53:47 INFO - PROCESS | 4157 | _x_x_mozilla_page_load_details 04:53:47 INFO - PROCESS | 4157 | |i|pagename|runs| 04:53:47 INFO - PROCESS | 4157 | |0;ai-astar;110;107;109;110;110;110;109;110;112;109 04:53:47 INFO - PROCESS | 4157 | |1;audio-beat-detection;151;123;125;183;125;130;144;124;171;123 04:53:47 INFO - PROCESS | 4157 | |2;audio-dft;160;161;162;160;160;160;161;161;160;160 04:53:47 INFO - PROCESS | 4157 | |3;audio-fft;74;75;75;122;75;75;74;74;98;75 04:53:47 INFO - PROCESS | 4157 | |4;audio-oscillator;83;85;116;85;85;85;124;84;85;121 04:53:47 INFO - PROCESS | 4157 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;116;116 04:53:47 INFO - PROCESS | 4157 | |6;imaging-darkroom;146;146;145;145;146;145;145;146;146;146 04:53:47 INFO - PROCESS | 4157 | |7;imaging-desaturate;95;96;96;95;95;96;95;95;95;95 04:53:47 INFO - PROCESS | 4157 | |8;json-parse-financial;50;49;49;51;51;51;51;50;52;51 04:53:47 INFO - PROCESS | 4157 | |9;json-stringify-tinderbox;58;59;58;58;59;59;58;59;59;59 04:53:47 INFO - PROCESS | 4157 | |10;stanford-crypto-aes;75;75;75;75;77;77;76;76;106;76 04:53:47 INFO - PROCESS | 4157 | |11;stanford-crypto-ccm;122;118;124;114;119;135;115;117;120;127 04:53:47 INFO - PROCESS | 4157 | |12;stanford-crypto-pbkdf2;154;154;157;152;153;152;152;151;152;153 04:53:47 INFO - PROCESS | 4157 | |13;stanford-crypto-sha256-iterative;61;62;62;60;61;62;62;61;60;63 04:53:47 INFO - PROCESS | 4157 | __end_tp_report 04:53:47 INFO - PROCESS | 4157 | __start_cc_report 04:53:47 INFO - PROCESS | 4157 | _x_x_mozilla_cycle_collect,1550 04:53:47 INFO - PROCESS | 4157 | __end_cc_report 04:53:47 INFO - PROCESS | 4157 | __startTimestamp1467892427484__endTimestamp 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | ------- Summary: start ------- 04:53:47 INFO - PROCESS | 4157 | Number of tests: 14 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 04:53:47 INFO - PROCESS | 4157 | Values: 110.0 107.0 109.0 110.0 110.0 110.0 109.0 110.0 112.0 109.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:137.00 stddev:21.94 (16.0%) stddev-sans-first:22.90 04:53:47 INFO - PROCESS | 4157 | Values: 151.0 123.0 125.0 183.0 125.0 130.0 144.0 124.0 171.0 123.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 04:53:47 INFO - PROCESS | 4157 | Values: 160.0 161.0 162.0 160.0 160.0 160.0 161.0 161.0 160.0 160.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:15.96 (21.3%) stddev-sans-first:16.68 04:53:47 INFO - PROCESS | 4157 | Values: 74.0 75.0 75.0 122.0 75.0 75.0 74.0 74.0 98.0 75.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:17.39 (20.5%) stddev-sans-first:17.87 04:53:47 INFO - PROCESS | 4157 | Values: 83.0 85.0 116.0 85.0 85.0 85.0 124.0 84.0 85.0 121.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:53:47 INFO - PROCESS | 4157 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:53:47 INFO - PROCESS | 4157 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:53:47 INFO - PROCESS | 4157 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 04:53:47 INFO - PROCESS | 4157 | Values: 50.0 49.0 49.0 51.0 51.0 51.0 51.0 50.0 52.0 51.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:53:47 INFO - PROCESS | 4157 | Values: 58.0 59.0 58.0 58.0 59.0 59.0 58.0 59.0 59.0 59.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:76.00 stddev:9.59 (12.6%) stddev-sans-first:10.07 04:53:47 INFO - PROCESS | 4157 | Values: 75.0 75.0 75.0 75.0 77.0 77.0 76.0 76.0 106.0 76.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:6.30 (5.2%) stddev-sans-first:6.67 04:53:47 INFO - PROCESS | 4157 | Values: 122.0 118.0 124.0 114.0 119.0 135.0 115.0 117.0 120.0 127.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:153.00 stddev:1.70 (1.1%) stddev-sans-first:1.76 04:53:47 INFO - PROCESS | 4157 | Values: 154.0 154.0 157.0 152.0 153.0 152.0 152.0 151.0 152.0 153.0 04:53:47 INFO - PROCESS | 4157 | 04:53:47 INFO - PROCESS | 4157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 04:53:47 INFO - PROCESS | 4157 | Values: 61.0 62.0 62.0 60.0 61.0 62.0 62.0 61.0 60.0 63.0 04:53:47 INFO - PROCESS | 4157 | -------- Summary: end -------- 04:53:47 INFO - PROCESS | 4157 | 04:53:48 INFO - TEST-INFO | 4157: exit 0 04:53:48 INFO - TEST-OK | kraken | took 59875ms 04:53:48 INFO - SUITE-END | took 1172s 04:53:48 INFO - Completed test suite (00:19:32) 04:53:48 INFO - javascript benchmark 04:53:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.450310698735, 3348.8995330140087, 3351.748618853587, 3372.072680012998, 3392.932141357173, 5400.189971504276, 5494.587905907063, 5511.641743286684, 5513.9448605513935, 5518.613697041209, 5432.782688692448, 5528.336599608053, 5529.198266251391, 5546.77812887485, 5564.4991950724425, 4927.7536123193695, 4989.800407983676, 5051.292819005343, 5085.872853178663, 5118.053160165363, 4888.853334399973, 5012.573931215833, 5057.317262169615, 5062.848114556551, 5097.108006098936, 4985.975070124662, 4990.151674215392, 5028.0, 5072.568831649314, 5074.28959945606, 5140.691558506502, 5142.434332223453, 5155.175171972504, 5163.251328557376, 5189.6107791915565, 4876.902461950741, 4928.827491037797, 4931.778069986859, 5036.320096786923, 5060.493950604947, 5326.414094449646, 5351.7056561889085, 5353.57171426285, 5356.517913387775, 5392.973035134838, 5883.882322353529, 5895.115732640095, 5909.290885093773, 5923.881522369572, 5925.140854576062, 5855.473007429352, 5909.113632955048, 5913.2608423947, 5915.556333275022, 6000.489958353545, 5546.944530554683, 5560.277163968658, 5579.107342825128, 5583.357913839879, 5584.860378490489, 5801.6809075500405, 6071.878562428727, 6073.1497590337385, 6075.665838378844, 6075.75696972125, 5695.316562012585, 5728.684922329312, 5735.3977832327, 5831.650100993954, 5833.358330583633, 5873.177755114288, 5873.941260587425, 5874.970625146932, 5904.7342869570975, 5905.291365036223, 5641.153826925994, 5730.025895597759, 5813.302403711582, 5814.447627475383, 5851.502622277069, 5749.770009199585, 5810.1575271586225, 5815.476607105381, 5818.854528636733, 5859.882802343929, 4504.189245935698, 4509.864704058883, 4513.864584062483, 4516.525764794715, 4539.046800171935, 3995.5405128410025, 4002.799860006988, 4031.032552187454, 4045.2314060328445, 4080.0207950091763, 5539.362973258127, 5562.582806289544, 5563.527100196528, 5565.693886836263, 5598.076317407664, 5928.555358348141, 5938.317093534212, 5940.257467816523, 5943.138244954457, 5962.0, 5336.7865285388925, 5523.116301391758, 5547.472990065938, 5561.582881283839, 5567.220589117445, 5006.349174607278, 5048.495150484922, 5050.823221187241, 5073.568746656501, 5079.212722028092, 6131.172291740647, 6142.201513803267, 6147.538934579835, 6154.5076393888385, 6156.661383623854, 5677.0, 5772.393898640582, 5818.970905145447, 5832.766689332379, 5891.675957822361, 6093.969530152321, 6094.9085763714465, 6099.0, 6101.237345331833, 6107.389261073857, 5743.942560574508, 5746.5402767779315, 5754.395788442153, 5761.193432919311, 5765.279340082489, 5698.54411647059, 5817.709114544171, 5858.150568167677, 5890.204822348928, 5964.135200395832, 5753.971230143822, 5784.7107644618445, 5785.4214578541805, 5785.508231800344, 5790.0, 5721.22763426932, 5760.481556659921, 5773.249477568057, 5773.393793651606, 5786.508146807569, 5488.4785945335125, 5590.161475778666, 5628.521575666115, 5643.181738647955, 5696.487316141567, 5755.827325180251, 5800.303963524404, 5801.8549536261935, 5808.099744539603, 5808.593398462067, 5487.64330318528, 5661.433856614306, 5665.178549110438, 5665.348484924287, 5665.745041473226], "value": 5429.838884712864, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.9789307374243, 656.0683828962873, 657.3196741372681, 667.8530723240887, 675.0347003784586, 33463.16342091446, 36291.45562816557, 45069.0, 45881.311780323325, 46038.53961460385, 47641.523584764145, 47957.28064079041, 47987.0, 48110.518894811044, 48157.7592112039, 9094.499802510876, 9240.491772952484, 9255.768605784842, 9262.583183756713, 9263.212626926686, 8346.87479687802, 10731.946340268327, 10951.780964380707, 10955.616553420632, 11320.943395283053, 11071.446427678584, 11126.38804865732, 11146.6098686546, 11155.609553665623, 11155.776884462306, 8573.0, 8846.557672116433, 11000.614978475754, 11069.667909962714, 11074.501647425845, 10667.573297068107, 11068.225224234307, 11071.391073490955, 11082.556697732161, 11480.942595287053, 41359.58640413587, 41918.790406047774, 46398.5360146401, 46581.30128048082, 46663.30005049927, 3615.837287322077, 4165.271077561415, 4483.170613436525, 4508.752018638974, 4561.087782443525, 35136.82431587826, 35690.28619427623, 35975.82012089949, 36029.639703602894, 36121.45817812735, 4079.224947260011, 4166.062635906927, 4176.600838719033, 4194.538600753915, 4269.466316710411, 396833.0, 396993.0, 397919.0, 398509.0, 399599.0, 68767.31232687709, 69328.0, 69404.0, 69630.30369696238, 69758.0, 40727.389089163684, 41652.791736041734, 41699.1660166801, 43622.781886090364, 44002.33996490055, 19918.402447926586, 19959.0, 20098.69851952222, 20101.49746256326, 20121.899390502953, 12497.25016499013, 14799.778003329959, 15103.169325687193, 15190.696186076217, 15302.770458443132, 22861.19985800489, 23123.537529249657, 23215.767842321362, 23228.257880659017, 23275.650865237036, 7797.7660670179985, 7929.167437419103, 8154.429189956646, 8158.184181581794, 8363.16368363171, 1002.588938535197, 1010.6260683547134, 1066.9970227985668, 1144.3248483394837, 1171.226990186473, 34566.82716586401, 35391.0, 35464.82267588697, 35537.64462355343, 35619.28761424809, 1143.3882872663085, 1242.099477878531, 1280.11032332528, 1302.6482849630736, 1341.6511706956262, 18350.81649183518, 18372.35696750607, 18523.166457509444, 18636.627267454576, 18695.626087478173, 560930.0, 564119.0, 566007.0, 567721.0, 568589.0, 66201.66899165473, 66841.0, 66872.66563667248, 66918.66540667265, 66938.66530667413, 1273.0770191611007, 1302.4790083966489, 1383.2115694054494, 1412.3856122586503, 1419.3754747910887, 32016.51975220327, 35655.82172089123, 36097.81951090228, 36443.63556364403, 36668.0, 54549.72725136349, 55158.448415516934, 55197.0, 55270.0, 55278.170827436814, 420621.0, 421791.0, 421974.0, 422144.0, 422889.0, 27457.17628471149, 27891.860540697977, 27964.720352796212, 28038.43923121567, 28162.718372816827, 51370.48629513657, 52309.7384513075, 52651.73674131758, 53183.20225196548, 53406.0, 43919.290645863475, 44677.0, 45017.774911125234, 45074.32388514109, 46711.29933051075, 43069.0, 43344.78327608342, 43446.34830477482, 44209.0, 44549.0, 44711.0, 45056.0, 45416.0, 45423.318650220936, 45639.087218256114, 38474.807625961694, 38713.61286387213, 39766.0, 40312.59687403088, 40341.39487907742, 28765.568516471852, 29251.85374073201, 29291.560626591043, 29411.705882940896, 29596.0], "value": 21831.560845455268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.59622762148337, 430.91381723655275, 433.93318214394424, 436.08639899410736, 436.1973967899065, 19047.52381190469, 20107.497312567193, 20778.89610551947, 21114.788852111513, 21145.471363215926, 19727.309544165957, 20098.397048088544, 20312.28906988252, 20315.695264571044, 20390.286339978065, 5592.804251851186, 5825.155352473888, 5862.70686465675, 5867.530597552207, 5875.294964604253, 5751.712414379264, 5752.65484070955, 5756.654600723949, 5761.078227483604, 5805.535557155417, 5688.146777983315, 5688.459596338341, 5690.5447564194765, 5696.231008813798, 5719.370869204384, 5672.943270567303, 7185.928140718578, 7598.886016709754, 7618.542887426716, 7619.504732192418, 7173.210946795848, 7375.926240737577, 7401.037865077506, 7522.247775222489, 7532.736354227576, 27542.311442214104, 27969.0, 28162.43675126486, 28794.712052879622, 28795.712042879513, 2489.3154382544762, 2503.4492411669403, 2530.000649743341, 2533.0, 2639.1158961747838, 15631.0, 16472.752908706378, 16674.666506669797, 16779.66440671192, 17283.222254998556, 2203.22886989554, 2206.6800313954386, 2207.834412419075, 2221.8777967211795, 2230.174835310945, 100409.49795250977, 100543.49728251385, 104672.0, 105024.4748776259, 105195.0, 18799.718004229948, 19032.809671903382, 19227.80772192288, 19461.12424940881, 19528.804711952984, 34415.82792086023, 34897.30205395878, 34987.125321867155, 35300.0, 35453.64546354555, 10740.140788736882, 10934.781304373868, 10938.398388088732, 11008.174386921013, 11532.654020379403, 9012.233960113464, 9027.954860225656, 9059.81880362389, 9163.404378715362, 9537.189338906272, 9835.754106147404, 9879.851802222973, 9889.20886329092, 9891.851622225673, 9987.800243995225, 3566.9108272292883, 3637.308911306843, 3738.43923411485, 3750.456183853326, 3822.3502004659276, 949.4493193947494, 950.5247376311844, 995.8406654935176, 1021.4688362051841, 1026.9435181064964, 19853.404397868086, 20245.0, 20259.79740202579, 20428.48928776763, 20477.180912763324, 995.571904081252, 999.2655398282257, 1008.5209525475341, 1012.2661070723666, 1053.378506681062, 10936.890631093587, 11297.343173798039, 11337.659870203906, 11440.199186056896, 11541.769164616828, 585022.0, 585200.0, 612340.0, 615159.0, 626162.8691856512, 99099.0, 103681.0, 103956.48021759842, 104897.80408783715, 105894.47052764687, 1086.9456527173609, 1105.546725842417, 1119.6585041562403, 1124.3197865291545, 1129.8983091521802, 17690.646187076443, 17742.379016734354, 18013.819861801214, 18469.261229550666, 18723.71914421312, 42922.35616465818, 43000.354994675734, 43841.78079109584, 43854.34218486661, 44170.0, 58502.41497584969, 59289.40710593011, 60421.39578604334, 60887.69556152191, 62425.0, 8949.731508054769, 9069.555392574584, 9160.267178625827, 9211.539423028957, 9389.436633801994, 13190.868091318964, 13434.05961582719, 13532.120412173177, 13669.111507751964, 13823.585292441243, 11700.857050048793, 11704.94147529257, 11820.76358472843, 11975.461104250155, 12078.51685932588, 12002.75994480088, 12022.729637207587, 12033.097517686383, 12172.391380430767, 12363.32001739877, 12043.75912481728, 12164.939175304067, 12180.330081845583, 12262.816057758962, 12263.26420414778, 8101.432899696964, 8905.777355565904, 9009.684661037094, 9090.409123407222, 9112.77218069527, 11837.585684501, 12438.813417798921, 12528.749425011267, 12628.43172057278, 12644.620661380173], "value": 10897.951130932908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.2227274998747, 1583.1530131379711, 1607.6141725985763, 1780.5904641932354, 1902.5814320849408, 9206.907930920688, 9344.06559344066, 9347.859782103265, 9819.509024548779, 9851.802963940718, 9560.713178604654, 9776.511174441284, 9779.511024448768, 9789.657361992331, 9792.951035244832, 2204.7464541577683, 2443.841150325223, 2498.5502609530367, 2504.298796337024, 2539.5301869154173, 2541.0344069253656, 2549.7195308516048, 2551.4897020595863, 2553.6807899012624, 2555.0674003988597, 2479.764422379871, 2524.7222805491383, 2532.151729170721, 2536.759007894247, 2540.618907163922, 2165.3828658832235, 2224.410531209239, 2407.843490173133, 2411.7467665895006, 2465.050955382173, 2494.4761600064007, 2502.0, 2514.0446630280376, 2518.382996165951, 2519.571672815626, 9647.758806029835, 9697.127258546694, 9702.078302561245, 9706.223502119814, 9709.514524273829, 5564.10974244119, 5687.289088863892, 5694.117411801136, 5700.0, 5704.401037891003, 3566.233259849119, 3607.693346065588, 3659.9085022874374, 3686.6129056448954, 3767.190054138346, 1151.4875880233299, 1153.6250718516517, 1155.3587758793867, 1199.8200269959489, 1251.943662535179, 13226.86773132266, 13238.404271807793, 13261.801072983913, 13271.800922986067, 13287.800682989762, 4991.176455884738, 4992.525710057539, 5009.398872135294, 5022.171341728647, 5068.113080210948, 10942.890571094347, 10990.890091099147, 11005.119590432747, 11024.0, 11033.0, 5660.2075709400715, 5669.319681638147, 5678.630888992202, 5686.175504551899, 5687.630304030225, 4524.25349817283, 5126.53861152498, 5164.122099243063, 5189.247559103909, 5341.198820177005, 4354.107407981356, 4361.629261512743, 4427.867163985085, 4455.376247325377, 4466.843660471868, 1363.9181649101085, 1393.909395889264, 1403.8876889848787, 1408.190290582919, 1413.1168019987508, 993.3890657245886, 1000.229823036258, 1000.9849852252222, 1008.077608987768, 1010.5755582655303, 6103.725332360054, 6149.0776383542825, 6231.781887634002, 6293.276273228637, 6331.398517140864, 483.29439019032606, 487.8560824556764, 494.5969035236271, 505.6207844116912, 511.8515630467197, 4073.4166922825, 4126.484189476316, 4151.211269858717, 4164.479440069991, 4230.111676547898, 11905.404729763477, 12276.631701048982, 12367.93816030932, 12377.195482293622, 12387.256764594153, 12147.331896745587, 12258.877411225774, 12268.202566833128, 12273.570425035081, 12282.078844086729, 8457.154284571494, 8467.49195048299, 8535.274501667303, 8930.464172149563, 9035.593398297093, 6199.845003874939, 6305.779297724557, 6390.5526613136635, 6409.743610255724, 6504.991726282434, 10736.409497477714, 10775.191860610643, 11284.661460156209, 11377.317360958368, 11391.772164556496, 11243.494042767932, 11334.149938754792, 11351.829722554334, 11357.602483913024, 11476.770464590494, 7593.240675932362, 7641.961790191013, 8204.630791614272, 8422.95788521078, 8603.053664096818, 8999.820003600022, 9537.046295370408, 9559.713208603753, 9593.664221752206, 9611.375260608038, 8374.623141958748, 8443.493390396596, 8578.227959483676, 8615.569221538773, 8625.137486251324, 8219.83560328802, 8255.25702686761, 8338.62476188585, 8476.872846907425, 8564.229219370287, 7107.076080109553, 7161.4270858330165, 7166.784996450115, 7480.0649918760155, 7482.289182527651, 5365.356157261153, 5456.345238571397, 5554.1391084381985, 5662.2639056922335, 5700.686462244616, 5287.709175995357, 5306.734663266744, 5445.156000819879, 5453.072977593739, 5473.343198816167], "value": 4899.3625436072825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.59176029962543, 329.3035230487518, 336.5809567088975, 340.1156991821263, 341.78979927344693, 5357.571394288452, 5383.515483606475, 5406.621536492442, 5429.809956651518, 5481.479259470354, 5102.5252752415045, 5138.0, 5340.49265319795, 5391.514763671269, 5414.512693857552, 4202.600752928467, 4211.978940105295, 4244.915101697964, 4250.341197114452, 4268.423762792022, 4250.53244143144, 4259.1268789897995, 4262.616364527192, 4269.274223382017, 4279.807408666617, 4016.9799151004204, 4088.6081642239324, 4198.8320467181275, 4206.284931561627, 4225.323948168294, 4163.10493243954, 4191.580841915815, 4197.538270790211, 4211.326187809951, 4213.747175169485, 3745.62543745626, 3750.1749615084636, 3764.4353346997896, 3767.6232376762377, 3777.2067865748227, 5197.272381866542, 5205.609579281569, 5206.114960456694, 5230.137027390476, 5339.225812257201, 4841.0, 4848.10310092634, 4859.271109333593, 4864.489228630978, 4883.096627123993, 5590.524805391506, 5645.407232240637, 5667.744951477152, 5674.914876276859, 5726.856828579277, 4055.5538890721996, 4186.5604111568155, 4205.11692544566, 4207.537170911197, 4215.957840421618, 5871.4128587141795, 5878.941210587882, 5895.644001879549, 5905.822825315247, 5920.141579470953, 4267.146570685875, 4269.7224680395675, 4270.807813648394, 4301.2257793597455, 4305.880471077542, 4211.810468528924, 4219.6202341789385, 4235.322348424299, 4239.42767726353, 4253.085586598834, 4798.592119669867, 4803.351547541107, 4808.3027960945465, 4842.176829938919, 4844.588210002189, 5629.453444330046, 5632.211490391349, 5642.871425714873, 5651.208830763697, 5655.3779084300695, 1423.4306277489088, 1434.2398528779763, 1449.0870751426744, 1506.517914267424, 1513.9621509462352, 945.4799860077068, 955.6811599991967, 960.9807803843884, 963.7927845513249, 974.0065133563726, 4872.171730805771, 4884.658073934862, 4912.582430493448, 4916.926246106311, 4961.950380496221, 5108.591312694975, 5135.666181698178, 5167.974160129251, 5168.457311982188, 5183.97408012965, 4846.636502262344, 4862.80548778052, 4909.607231421478, 4963.677360971526, 5150.381954165524, 3113.517404802259, 3133.81197128173, 3150.7951983121025, 3168.9859245041366, 3173.222560472699, 6116.541259405562, 6153.815385538441, 6167.136600875881, 6177.2587289525545, 6191.783287584913, 5850.3564607893095, 5862.70686465675, 5873.530117590668, 5881.852953676107, 5905.970470147622, 6082.080601311395, 6083.178770866053, 6083.695815209222, 6090.847728806815, 6094.238220222473, 5595.216669666332, 5803.564732644984, 5829.7085145743395, 5833.716582351876, 5856.238688970407, 5776.7111644418455, 5814.883702326015, 5827.94172058274, 5836.9493491172, 5837.6497410155525, 6118.449339559461, 6137.294211165595, 6140.048292514667, 6152.723127459186, 6185.165002724754, 3941.60583941615, 4107.89730256734, 4113.91772164561, 4137.731047481904, 4153.605407486284, 5625.690587017753, 5780.21967034445, 5781.277340332458, 5811.244538210006, 5817.650940943557, 5629.746661400329, 5681.9147712783515, 5705.828825135252, 5732.656040637575, 5749.993751093458, 5606.327240730975, 5674.716264186856, 5685.204071430086, 5695.45893140151, 5716.685582293014, 5346.572274217975, 5532.972335138459, 5598.824246908032, 5658.462446067617, 5682.403347648603, 5673.631213971079, 5715.428457154251, 5745.942540574708, 5773.364929857628, 5774.711264436845, 5501.642393244426, 5587.189857470726, 5593.664380137205, 5603.663780173202, 5620.803271885465], "value": 4307.556267875004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.4345314826473, 815.465869855245, 842.7345386203342, 850.5152063323906, 902.584810986946, 16490.42283520077, 16522.42171523997, 17095.14524273786, 17176.828231717678, 17343.479695609152, 15830.76253856193, 15864.28610712518, 15961.600959975978, 15992.600184995352, 15993.84006159938, 728.2971932085536, 848.974530764075, 859.4284800607588, 859.7764581208884, 870.9390342676015, 879.6701237036111, 880.9691660791874, 881.497546398553, 887.3921363865741, 890.1143362354467, 925.1165137293868, 925.6112432778216, 926.6386109417333, 926.9165775080241, 927.2952556057378, 762.8169239382536, 779.5244900610651, 890.2210565754964, 915.0666320353268, 920.3327587499043, 686.4954258619911, 686.5125760709902, 686.5160062156168, 686.5297271369128, 687.2577616174569, 15539.0, 15563.844361556467, 15615.531534053996, 15619.531414057596, 15621.062736235863, 15307.158106304149, 15309.923450382788, 15399.384024639001, 15469.303881325368, 15624.296906639229, 13095.279759613217, 13103.410346534429, 13253.602391928258, 13291.468341266338, 13341.466341346335, 4750.833720819789, 4756.500567440404, 4803.063402636487, 4810.7113573185725, 4887.242477416006, 73981.0, 78263.21736782616, 78696.21303786946, 79084.60457697732, 79793.20206797974, 11434.142439317084, 11726.651435085074, 11957.940210298893, 12091.214071085351, 12698.873011269954, 21417.46456338573, 21453.570928581343, 21461.03425345863, 21465.89267053686, 21494.0, 9023.593938272794, 9070.682526111686, 9310.115539023782, 9464.95267523658, 9483.573239204114, 4968.478309777493, 5151.639385243072, 5164.1995490699, 5194.818181363709, 5280.9207861882105, 3700.500432441586, 3812.5806161322234, 3813.84744610218, 3818.7899665518107, 3819.4461803038403, 484.6946423753084, 677.8034370032635, 682.3619915379137, 682.6313790553145, 683.4976292425064, 705.6260182103493, 785.1089013969072, 786.9331106855867, 789.214731342318, 824.6289169873581, 10370.844437333446, 10551.94724026375, 10627.574897004188, 10735.355878647306, 11251.156163287622, 795.8965334506477, 805.3476683886071, 823.9629216685264, 833.1044127562773, 835.6156168162591, 5062.443131255559, 5065.265536497187, 5095.515925987025, 5121.359830021247, 5123.2827404163445, 124461.75538244683, 126943.0, 127283.27225274885, 129661.0, 130402.34798826135, 107815.46092269645, 109448.0, 110201.0, 111782.0, 112500.43749781199, 93537.53231233801, 94631.52684236535, 95170.0, 95375.0, 95603.52198239103, 9678.322517423712, 9696.0788725071, 9794.510274486389, 9841.212702983601, 9853.458059806779, 56551.71724141353, 57304.14043789263, 57723.0, 58725.412745871996, 61598.38401615927, 67453.66273168602, 68418.0, 79585.0, 86679.0, 87253.56373218093, 12119.575814846437, 13909.165450073027, 14245.145291282557, 14475.131492110086, 14709.190994494977, 14057.367418465989, 14655.047421917541, 14686.0, 15754.369825206863, 16369.590760231089, 14023.649408764863, 15390.153541555323, 15405.416153020169, 15751.44869929547, 15906.52280431589, 14706.19115948633, 15394.15332156742, 15524.379024839332, 15702.057876527444, 15920.601984950468, 14818.40726370933, 15173.620659483602, 15286.770698439756, 15413.0, 15754.76367854506, 11685.824712629148, 11712.414379280832, 11843.58547450835, 11907.404629768303, 12482.687932801753, 11865.169438139248, 11907.642770716893, 12013.579524716593, 12161.209521381083, 12333.260004399765], "value": 8183.348459778751, "unit": "score"}], "name": "dromaeo_css", "value": 7788.030407758039, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 112.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 125.0, 183.0, 125.0, 130.0, 144.0, 124.0, 171.0, 123.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 122.0, 75.0, 75.0, 74.0, 74.0, 98.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 116.0, 85.0, 85.0, 85.0, 124.0, 84.0, 85.0, 121.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 51.0, 51.0, 51.0, 51.0, 50.0, 52.0, 51.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 77.0, 77.0, 76.0, 76.0, 106.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 124.0, 114.0, 119.0, 135.0, 115.0, 117.0, 120.0, 127.0], "value": 121.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 157.0, 152.0, 153.0, 152.0, 152.0, 151.0, 152.0, 153.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 60.0, 61.0, 62.0, 62.0, 61.0, 60.0, 63.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1467.8, "alertThreshold": 2.0}]} 04:53:48 INFO - Return code: 0 04:53:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:48 ERROR - # TBPL SUCCESS # 04:53:48 INFO - Running post-action listener: _resource_record_post_action 04:53:48 INFO - ##### 04:53:48 INFO - ##### Finished run-tests step (success) 04:53:48 INFO - ##### 04:53:48 INFO - Running post-run listener: _resource_record_post_run 04:53:48 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 510058496; Read time: 16; Write time: 410932 04:53:48 INFO - TinderboxPrint: CPU usage
13.1% 04:53:48 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 04:53:48 INFO - TinderboxPrint: I/O write bytes / time
510,058,496 / 410,932 04:53:48 INFO - TinderboxPrint: CPU idle
8,250.3 (86.9%) 04:53:48 INFO - TinderboxPrint: CPU user
1,196.9 (12.6%) 04:53:48 INFO - TinderboxPrint: Swap in / out
0 / 0 04:53:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 264130560; Read time: 0; Write time: 255472 04:53:48 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245927936; Read time: 16; Write time: 155460 04:53:49 INFO - Running post-run listener: _upload_blobber_files 04:53:49 INFO - Blob upload gear active. 04:53:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:49 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 04:53:49 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'] 04:53:49 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 04:53:49 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:50 INFO - (blobuploader) - INFO - Done attempting. 04:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:51 INFO - (blobuploader) - INFO - Done attempting. 04:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:54 INFO - (blobuploader) - INFO - Done attempting. 04:53:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:54 INFO - Return code: 0 04:53:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd4580db2a5bf9e9218552ef75d2607c5b377d651cd51047dbdb262e8b63bb85f7e2e1dc60669f832cff2a2e64b73d56a2ac3eae08f717134f3fc0ee3a1cf08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10154779b05d1f46de82e8abfcbad15b46d62b6f3239041b6d0ed390065d5d669df7fadec7cb41dade47f1e16815b75490be5739288fa9508c26104a4ebf0440", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/139e198f89ebea0cc48942b00991ee5740ec42f20c0386edf570b3e7d2d30bcdcf99ac608f775ddfc3f65a47f54840f6c2448db7afee849e109a09bc7a2460a1"} 04:53:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:54 INFO - Contents: 04:53:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd4580db2a5bf9e9218552ef75d2607c5b377d651cd51047dbdb262e8b63bb85f7e2e1dc60669f832cff2a2e64b73d56a2ac3eae08f717134f3fc0ee3a1cf08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10154779b05d1f46de82e8abfcbad15b46d62b6f3239041b6d0ed390065d5d669df7fadec7cb41dade47f1e16815b75490be5739288fa9508c26104a4ebf0440", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/139e198f89ebea0cc48942b00991ee5740ec42f20c0386edf570b3e7d2d30bcdcf99ac608f775ddfc3f65a47f54840f6c2448db7afee849e109a09bc7a2460a1"} 04:53:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:54 INFO - Copying logs to upload dir... 04:53:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.127672 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-07 04:53:55.381759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:53:55.390780) ========= 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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 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/fd4580db2a5bf9e9218552ef75d2607c5b377d651cd51047dbdb262e8b63bb85f7e2e1dc60669f832cff2a2e64b73d56a2ac3eae08f717134f3fc0ee3a1cf08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10154779b05d1f46de82e8abfcbad15b46d62b6f3239041b6d0ed390065d5d669df7fadec7cb41dade47f1e16815b75490be5739288fa9508c26104a4ebf0440", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/139e198f89ebea0cc48942b00991ee5740ec42f20c0386edf570b3e7d2d30bcdcf99ac608f775ddfc3f65a47f54840f6c2448db7afee849e109a09bc7a2460a1"} build_url:https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/EdJhTECcTwqoMOLmYmsnKg/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/fd4580db2a5bf9e9218552ef75d2607c5b377d651cd51047dbdb262e8b63bb85f7e2e1dc60669f832cff2a2e64b73d56a2ac3eae08f717134f3fc0ee3a1cf08c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10154779b05d1f46de82e8abfcbad15b46d62b6f3239041b6d0ed390065d5d669df7fadec7cb41dade47f1e16815b75490be5739288fa9508c26104a4ebf0440", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/139e198f89ebea0cc48942b00991ee5740ec42f20c0386edf570b3e7d2d30bcdcf99ac608f775ddfc3f65a47f54840f6c2448db7afee849e109a09bc7a2460a1"}' ========= master_lag: 0.75 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:53:56.153026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:53:56.157501) ========= 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=41bf3e9aed84707956354da8000001c5-1467891200.276273-1038866527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003964 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:53:56.198987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:53:56.199329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:53:56.203398) ========= ========= Total master_lag: 1.51 =========