builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1467041017.9 results: success (0) buildid: 20160627055325 builduid: 09aa9debd42848d8af190b0f0fa973a5 revision: 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:37.900851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:37.901413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:37.901828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:37.918214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:37.918562) ========= 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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:23:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-27 08:23:38 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.058129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.058520) ========= 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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017383 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.111443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.112082) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f --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 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f --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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:23:38,229 truncating revision to first 12 chars 2016-06-27 08:23:38,229 Setting DEBUG logging. 2016-06-27 08:23:38,229 attempt 1/10 2016-06-27 08:23:38,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/74763893c0f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:23:38,566 unpacking tar archive at: mozilla-aurora-74763893c0f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.774376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.774938) ========= script_repo_revision: 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.775728) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.776078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:23:38.787389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-27 08:23:38.787735) ========= /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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:38 INFO - MultiFileLogger online at 20160627 08:23:38 in /builds/slave/test 08:23:38 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 08:23:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:38 INFO - {'append_to_log': False, 08:23:38 INFO - 'base_work_dir': '/builds/slave/test', 08:23:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:23:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:38 INFO - 'branch': 'Mozilla-Aurora', 08:23:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:38 INFO - 'config_files': ('talos/linux_config.py',), 08:23:38 INFO - 'default_actions': ('clobber', 08:23:38 INFO - 'read-buildbot-config', 08:23:38 INFO - 'download-and-extract', 08:23:38 INFO - 'populate-webroot', 08:23:38 INFO - 'create-virtualenv', 08:23:38 INFO - 'install', 08:23:38 INFO - 'run-tests'), 08:23:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:38 INFO - 'download_minidump_stackwalk': True, 08:23:38 INFO - 'download_symbols': 'ondemand', 08:23:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:38 INFO - 'installer_path': 'installer.exe', 08:23:38 INFO - 'log_level': 'info', 08:23:38 INFO - 'log_name': 'talos', 08:23:38 INFO - 'log_to_console': True, 08:23:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:38 INFO - 'opt_config_files': (), 08:23:38 INFO - 'pip_index': False, 08:23:38 INFO - 'sps_profile': False, 08:23:38 INFO - 'sps_profile_interval': 0, 08:23:38 INFO - 'suite': 'dromaeojs', 08:23:38 INFO - 'system_bits': '32', 08:23:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:38 INFO - 'title': 'talos-linux64-ix-053', 08:23:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:38 INFO - 'use_talos_json': True, 08:23:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:38 INFO - 'work_dir': 'build'} 08:23:38 INFO - ##### 08:23:38 INFO - ##### Running clobber step. 08:23:38 INFO - ##### 08:23:38 INFO - Running pre-action listener: _resource_record_pre_action 08:23:38 INFO - Running main action method: clobber 08:23:38 INFO - rmtree: /builds/slave/test/build 08:23:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:39 INFO - Running post-action listener: _resource_record_post_action 08:23:39 INFO - ##### 08:23:39 INFO - ##### Finished clobber step (success) 08:23:39 INFO - ##### 08:23:39 INFO - ##### 08:23:39 INFO - ##### Running read-buildbot-config step. 08:23:39 INFO - ##### 08:23:39 INFO - Running pre-action listener: _resource_record_pre_action 08:23:39 INFO - Running main action method: read_buildbot_config 08:23:39 INFO - Using buildbot properties: 08:23:39 INFO - { 08:23:39 INFO - "project": "", 08:23:39 INFO - "product": "firefox", 08:23:39 INFO - "script_repo_revision": "production", 08:23:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:23:39 INFO - "repository": "", 08:23:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:23:39 INFO - "buildid": "20160627055325", 08:23:39 INFO - "pgo_build": "True", 08:23:39 INFO - "basedir": "/builds/slave/test", 08:23:39 INFO - "buildnumber": 580, 08:23:39 INFO - "slavename": "talos-linux64-ix-053", 08:23:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:39 INFO - "platform": "ubuntu64_hw", 08:23:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:23:39 INFO - "branch": "mozilla-aurora", 08:23:39 INFO - "repo_path": "releases/mozilla-aurora", 08:23:39 INFO - "revision": "74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f", 08:23:39 INFO - "stage_platform": "linux64-pgo", 08:23:39 INFO - "builduid": "09aa9debd42848d8af190b0f0fa973a5", 08:23:39 INFO - "slavebuilddir": "test" 08:23:39 INFO - } 08:23:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 08:23:39 INFO - Running post-action listener: _resource_record_post_action 08:23:39 INFO - ##### 08:23:39 INFO - ##### Finished read-buildbot-config step (success) 08:23:39 INFO - ##### 08:23:39 INFO - ##### 08:23:39 INFO - ##### Running download-and-extract step. 08:23:39 INFO - ##### 08:23:39 INFO - Running pre-action listener: _resource_record_pre_action 08:23:39 INFO - Running main action method: download_and_extract 08:23:39 INFO - mkdir: /builds/slave/test/build/tests 08:23: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')]} 08:23:39 INFO - https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:23:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:23:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:23:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:40 INFO - Downloaded 1361 bytes. 08:23:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:23:40 INFO - Using the following test package requirements: 08:23:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:23:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:23:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'jsshell-linux-x86_64.zip'], 08:23:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:23:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:23:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:23:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:40 INFO - https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:41 INFO - Downloaded 24522651 bytes. 08:23:41 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'] 08:23:41 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 08:23:42 INFO - Return code: 0 08:23:42 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 08:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:42 INFO - https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:43 INFO - Downloaded 24522651 bytes. 08:23:43 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'] 08:23:43 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 08:23:45 INFO - Return code: 0 08:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:45 INFO - https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:46 INFO - Downloaded 10833369 bytes. 08:23:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:23:46 INFO - Return code: 0 08:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:46 INFO - https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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 08:23:47 INFO - Downloaded 63598206 bytes. 08:23:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:23:47 INFO - mkdir: /builds/slave/test/properties 08:23:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:47 INFO - Contents: 08:23:47 INFO - build_url:https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:23:48 INFO - Running post-action listener: _resource_record_post_action 08:23:48 INFO - Running post-action listener: set_extra_try_arguments 08:23:48 INFO - ##### 08:23:48 INFO - ##### Finished download-and-extract step (success) 08:23:48 INFO - ##### 08:23:48 INFO - ##### 08:23:48 INFO - ##### Running populate-webroot step. 08:23:48 INFO - ##### 08:23:48 INFO - Running pre-action listener: _resource_record_pre_action 08:23:48 INFO - Running main action method: populate_webroot 08:23:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:48 INFO - '--tppagecycles', 08:23:48 INFO - '7'], 08:23:48 INFO - 'tests': ['tsvgm']}}, 08:23:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['damp', 'tps']}, 08:23:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'tests': ['damp', 'tps']}, 08:23:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['dromaeo_dom']}, 08:23:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['a11yr', 08:23:48 INFO - 'ts_paint', 08:23:48 INFO - 'tpaint', 08:23:48 INFO - 'sessionrestore', 08:23:48 INFO - 'sessionrestore_no_auto_restore', 08:23:48 INFO - 'tabpaint']}, 08:23:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['tsvgx', 08:23:48 INFO - 'tsvgr_opacity', 08:23:48 INFO - 'tart', 08:23:48 INFO - 'tscrollx', 08:23:48 INFO - 'cart']}, 08:23:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:48 INFO - 'tsvgr_opacity', 08:23:48 INFO - 'tart', 08:23:48 INFO - 'tscrollx', 08:23:48 INFO - 'cart']}, 08:23:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'talos_options': ['--disable-e10s'], 08:23:48 INFO - 'tests': ['tp5o']}, 08:23:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'tests': ['tp5o']}, 08:23:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'talos_options': ['--disable-e10s', 08:23:48 INFO - '--xperf_path', 08:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:48 INFO - 'tests': ['tp5n']}, 08:23:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:48 INFO - 'talos_options': ['--xperf_path', 08:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:48 INFO - 'tests': ['tp5n']}}, 08:23:48 INFO - 'talos.zip': {'path': '', 08:23:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:48 INFO - Running post-action listener: _resource_record_post_action 08:23:48 INFO - ##### 08:23:48 INFO - ##### Finished populate-webroot step (success) 08:23:48 INFO - ##### 08:23:48 INFO - ##### 08:23:48 INFO - ##### Running create-virtualenv step. 08:23:48 INFO - ##### 08:23:48 INFO - Running pre-action listener: _resource_record_pre_action 08:23:48 INFO - Running main action method: create_virtualenv 08:23:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:23:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:48 INFO - Using real prefix '/usr' 08:23:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:51 INFO - Installing pip.................done. 08:23:51 INFO - Return code: 0 08:23:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:51 INFO - Using env: {'DISPLAY': ':0', 08:23:51 INFO - 'HOME': '/home/cltbld', 08:23:51 INFO - 'LANG': 'en_US.UTF-8', 08:23:51 INFO - 'LANGUAGE': 'en_US:en', 08:23:51 INFO - 'LOGNAME': 'cltbld', 08:23:51 INFO - 'MAIL': '/var/mail/cltbld', 08:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:51 INFO - 'MOZ_NO_REMOTE': '1', 08:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:51 INFO - 'NO_EM_RESTART': '1', 08:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:51 INFO - 'PWD': '/builds/slave/test', 08:23:51 INFO - 'SHELL': '/bin/bash', 08:23:51 INFO - 'SHLVL': '1', 08:23:51 INFO - 'TERM': 'linux', 08:23:51 INFO - 'TMOUT': '86400', 08:23:51 INFO - 'USER': 'cltbld', 08:23:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:51 INFO - '_': '/tools/buildbot/bin/python'} 08:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:51 INFO - Cleaning up... 08:23:51 INFO - Return code: 0 08:23:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:23:51 INFO - Using env: {'DISPLAY': ':0', 08:23:51 INFO - 'HOME': '/home/cltbld', 08:23:51 INFO - 'LANG': 'en_US.UTF-8', 08:23:51 INFO - 'LANGUAGE': 'en_US:en', 08:23:51 INFO - 'LOGNAME': 'cltbld', 08:23:51 INFO - 'MAIL': '/var/mail/cltbld', 08:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:51 INFO - 'MOZ_NO_REMOTE': '1', 08:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:51 INFO - 'NO_EM_RESTART': '1', 08:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:51 INFO - 'PWD': '/builds/slave/test', 08:23:51 INFO - 'SHELL': '/bin/bash', 08:23:51 INFO - 'SHLVL': '1', 08:23:51 INFO - 'TERM': 'linux', 08:23:51 INFO - 'TMOUT': '86400', 08:23:51 INFO - 'USER': 'cltbld', 08:23:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:51 INFO - '_': '/tools/buildbot/bin/python'} 08:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:51 INFO - Downloading/unpacking psutil>=3.1.1 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:53 INFO - Installing collected packages: psutil 08:23:53 INFO - Running setup.py install for psutil 08:23:53 INFO - building 'psutil._psutil_linux' extension 08:23:53 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 08:23:53 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 08:23:53 INFO - building 'psutil._psutil_posix' extension 08:23:53 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 08:23:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:54 INFO - Successfully installed psutil 08:23:54 INFO - Cleaning up... 08:23:54 INFO - Return code: 0 08:23:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:54 INFO - Using env: {'DISPLAY': ':0', 08:23:54 INFO - 'HOME': '/home/cltbld', 08:23:54 INFO - 'LANG': 'en_US.UTF-8', 08:23:54 INFO - 'LANGUAGE': 'en_US:en', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MAIL': '/var/mail/cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SHLVL': '1', 08:23:54 INFO - 'TERM': 'linux', 08:23:54 INFO - 'TMOUT': '86400', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - '_': '/tools/buildbot/bin/python'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:56 INFO - Installing collected packages: mozsystemmonitor 08:23:56 INFO - Running setup.py install for mozsystemmonitor 08:23:56 INFO - Successfully installed mozsystemmonitor 08:23:56 INFO - Cleaning up... 08:23:56 INFO - Return code: 0 08:23:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:23:56 INFO - Using env: {'DISPLAY': ':0', 08:23:56 INFO - 'HOME': '/home/cltbld', 08:23:56 INFO - 'LANG': 'en_US.UTF-8', 08:23:56 INFO - 'LANGUAGE': 'en_US:en', 08:23:56 INFO - 'LOGNAME': 'cltbld', 08:23:56 INFO - 'MAIL': '/var/mail/cltbld', 08:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:56 INFO - 'MOZ_NO_REMOTE': '1', 08:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:56 INFO - 'NO_EM_RESTART': '1', 08:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:56 INFO - 'PWD': '/builds/slave/test', 08:23:56 INFO - 'SHELL': '/bin/bash', 08:23:56 INFO - 'SHLVL': '1', 08:23:56 INFO - 'TERM': 'linux', 08:23:56 INFO - 'TMOUT': '86400', 08:23:56 INFO - 'USER': 'cltbld', 08:23:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:56 INFO - '_': '/tools/buildbot/bin/python'} 08:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:56 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 08:23:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:58 INFO - warning: no files found matching '*.txt' 08:23:58 INFO - no previously-included directories found matching 'build' 08:23:58 INFO - no previously-included directories found matching 'dist' 08:23:58 INFO - no previously-included directories found matching '.git*' 08:23:58 INFO - Installing collected packages: jsonschema, functools32 08:23:58 INFO - Running setup.py install for functools32 08:23:58 INFO - warning: no files found matching '*.txt' 08:23:58 INFO - no previously-included directories found matching 'build' 08:23:58 INFO - no previously-included directories found matching 'dist' 08:23:58 INFO - no previously-included directories found matching '.git*' 08:23:59 INFO - Successfully installed jsonschema functools32 08:23:59 INFO - Cleaning up... 08:23:59 INFO - Return code: 0 08:23:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:59 INFO - Using env: {'DISPLAY': ':0', 08:23:59 INFO - 'HOME': '/home/cltbld', 08:23:59 INFO - 'LANG': 'en_US.UTF-8', 08:23:59 INFO - 'LANGUAGE': 'en_US:en', 08:23:59 INFO - 'LOGNAME': 'cltbld', 08:23:59 INFO - 'MAIL': '/var/mail/cltbld', 08:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:59 INFO - 'MOZ_NO_REMOTE': '1', 08:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:59 INFO - 'NO_EM_RESTART': '1', 08:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:59 INFO - 'PWD': '/builds/slave/test', 08:23:59 INFO - 'SHELL': '/bin/bash', 08:23:59 INFO - 'SHLVL': '1', 08:23:59 INFO - 'TERM': 'linux', 08:23:59 INFO - 'TMOUT': '86400', 08:23:59 INFO - 'USER': 'cltbld', 08:23:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:59 INFO - '_': '/tools/buildbot/bin/python'} 08:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - Downloading docopt-0.6.1.tar.gz 08:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:01 INFO - Running setup.py install for blobuploader 08:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:02 INFO - Running setup.py install for requests 08:24:02 INFO - Running setup.py install for docopt 08:24:02 INFO - Successfully installed blobuploader requests docopt 08:24:02 INFO - Cleaning up... 08:24:02 INFO - Return code: 0 08:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:24:02 INFO - Using env: {'DISPLAY': ':0', 08:24:02 INFO - 'HOME': '/home/cltbld', 08:24:02 INFO - 'LANG': 'en_US.UTF-8', 08:24:02 INFO - 'LANGUAGE': 'en_US:en', 08:24:02 INFO - 'LOGNAME': 'cltbld', 08:24:02 INFO - 'MAIL': '/var/mail/cltbld', 08:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:02 INFO - 'MOZ_NO_REMOTE': '1', 08:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:02 INFO - 'NO_EM_RESTART': '1', 08:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:02 INFO - 'PWD': '/builds/slave/test', 08:24:02 INFO - 'SHELL': '/bin/bash', 08:24:02 INFO - 'SHLVL': '1', 08:24:02 INFO - 'TERM': 'linux', 08:24:02 INFO - 'TMOUT': '86400', 08:24:02 INFO - 'USER': 'cltbld', 08:24:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:02 INFO - '_': '/tools/buildbot/bin/python'} 08:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:02 INFO - Running setup.py (path:/tmp/pip-0mcUDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:02 INFO - Running setup.py (path:/tmp/pip-FaXfwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:02 INFO - Running setup.py (path:/tmp/pip-b6nesl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:02 INFO - Running setup.py (path:/tmp/pip-cDeiWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:03 INFO - Running setup.py (path:/tmp/pip-jNNcMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:03 INFO - Running setup.py (path:/tmp/pip-lr0Klo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:03 INFO - Running setup.py (path:/tmp/pip-yhMQ2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:03 INFO - Running setup.py (path:/tmp/pip-qfsEsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:03 INFO - Running setup.py (path:/tmp/pip-jFi90W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:03 INFO - Running setup.py (path:/tmp/pip-ES5FTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:03 INFO - Running setup.py (path:/tmp/pip-gTnX_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:03 INFO - Running setup.py (path:/tmp/pip-MLuIvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:03 INFO - Running setup.py (path:/tmp/pip-zzTw2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:03 INFO - Running setup.py (path:/tmp/pip-9NUAYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:03 INFO - Running setup.py (path:/tmp/pip-YO62Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:03 INFO - Running setup.py (path:/tmp/pip-BmMpHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:03 INFO - Running setup.py (path:/tmp/pip-sZLAgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:03 INFO - Running setup.py install for manifestparser 08:24:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Running setup.py install for mozcrash 08:24:04 INFO - Running setup.py install for mozdebug 08:24:04 INFO - Running setup.py install for mozdevice 08:24:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Running setup.py install for mozfile 08:24:04 INFO - Running setup.py install for mozhttpd 08:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Running setup.py install for mozinfo 08:24:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Running setup.py install for mozInstall 08:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:04 INFO - Running setup.py install for mozleak 08:24:04 INFO - Running setup.py install for mozlog 08:24:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Running setup.py install for moznetwork 08:24:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Running setup.py install for mozprocess 08:24:05 INFO - Running setup.py install for mozprofile 08:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Running setup.py install for mozrunner 08:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Running setup.py install for mozscreenshot 08:24:05 INFO - Running setup.py install for moztest 08:24:05 INFO - Running setup.py install for mozversion 08:24:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:05 INFO - Cleaning up... 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:05 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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'DISPLAY': ':0', 08:24:05 INFO - 'HOME': '/home/cltbld', 08:24:05 INFO - 'LANG': 'en_US.UTF-8', 08:24:05 INFO - 'LANGUAGE': 'en_US:en', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MAIL': '/var/mail/cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SHLVL': '1', 08:24:05 INFO - 'TERM': 'linux', 08:24:05 INFO - 'TMOUT': '86400', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - '_': '/tools/buildbot/bin/python'} 08:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:05 INFO - Running setup.py (path:/tmp/pip-C4EItO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:06 INFO - Running setup.py (path:/tmp/pip-wX1Pzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:06 INFO - Running setup.py (path:/tmp/pip-7Mdiyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:06 INFO - Running setup.py (path:/tmp/pip-lH3Av7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:06 INFO - Running setup.py (path:/tmp/pip-EEQaEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:06 INFO - Running setup.py (path:/tmp/pip-6M4Du7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:06 INFO - Running setup.py (path:/tmp/pip-IUuuAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:06 INFO - Running setup.py (path:/tmp/pip-Z904Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:06 INFO - Running setup.py (path:/tmp/pip-dOnbXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:06 INFO - Running setup.py (path:/tmp/pip-QRYgYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:06 INFO - Running setup.py (path:/tmp/pip-be0B8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:06 INFO - Running setup.py (path:/tmp/pip-DR9Pui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:06 INFO - Running setup.py (path:/tmp/pip-dJ_43N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:06 INFO - Running setup.py (path:/tmp/pip-rlisT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:06 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)) 08:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:07 INFO - Running setup.py (path:/tmp/pip-KsLn1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:07 INFO - Running setup.py (path:/tmp/pip-3sXU3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:07 INFO - Running setup.py (path:/tmp/pip-PWkr_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:09 INFO - Downloading blessings-1.6.tar.gz 08:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:09 INFO - Installing collected packages: blessings 08:24:09 INFO - Running setup.py install for blessings 08:24:09 INFO - Successfully installed blessings 08:24:09 INFO - Cleaning up... 08:24:09 INFO - Return code: 0 08:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:09 INFO - Reading from file tmpfile_stdout 08:24:09 INFO - Current package versions: 08:24:09 INFO - argparse == 1.2.1 08:24:09 INFO - blessings == 1.6 08:24:09 INFO - blobuploader == 1.2.4 08:24:09 INFO - docopt == 0.6.1 08:24:09 INFO - functools32 == 3.2.3-2 08:24:09 INFO - jsonschema == 2.5.1 08:24:09 INFO - manifestparser == 1.1 08:24:09 INFO - mozInstall == 1.12 08:24:09 INFO - mozcrash == 0.17 08:24:09 INFO - mozdebug == 0.1 08:24:09 INFO - mozdevice == 0.48 08:24:09 INFO - mozfile == 1.2 08:24:09 INFO - mozhttpd == 0.7 08:24:09 INFO - mozinfo == 0.9 08:24:09 INFO - mozleak == 0.1 08:24:09 INFO - mozlog == 3.2 08:24:09 INFO - moznetwork == 0.27 08:24:09 INFO - mozprocess == 0.22 08:24:09 INFO - mozprofile == 0.28 08:24:09 INFO - mozrunner == 6.11 08:24:09 INFO - mozscreenshot == 0.1 08:24:09 INFO - mozsystemmonitor == 0.3 08:24:09 INFO - moztest == 0.7 08:24:09 INFO - mozversion == 1.4 08:24:09 INFO - psutil == 3.1.1 08:24:09 INFO - requests == 1.2.3 08:24:09 INFO - wsgiref == 0.1.2 08:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:09 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')]} 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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')]} 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:24:09 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 08:24:09 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 08:24:09 INFO - Using env: {'DISPLAY': ':0', 08:24:09 INFO - 'HOME': '/home/cltbld', 08:24:09 INFO - 'LANG': 'en_US.UTF-8', 08:24:09 INFO - 'LANGUAGE': 'en_US:en', 08:24:09 INFO - 'LOGNAME': 'cltbld', 08:24:09 INFO - 'MAIL': '/var/mail/cltbld', 08:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:09 INFO - 'MOZ_NO_REMOTE': '1', 08:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:09 INFO - 'NO_EM_RESTART': '1', 08:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:09 INFO - 'PWD': '/builds/slave/test', 08:24:09 INFO - 'SHELL': '/bin/bash', 08:24:09 INFO - 'SHLVL': '1', 08:24:09 INFO - 'TERM': 'linux', 08:24:09 INFO - 'TMOUT': '86400', 08:24:09 INFO - 'USER': 'cltbld', 08:24:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:09 INFO - '_': '/tools/buildbot/bin/python'} 08:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 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)) 08:24:09 INFO - Cleaning up... 08:24:09 INFO - Return code: 0 08:24:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:24:09 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')]} 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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')]} 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:24:09 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 08:24:09 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 08:24:09 INFO - Using env: {'DISPLAY': ':0', 08:24:09 INFO - 'HOME': '/home/cltbld', 08:24:09 INFO - 'LANG': 'en_US.UTF-8', 08:24:09 INFO - 'LANGUAGE': 'en_US:en', 08:24:09 INFO - 'LOGNAME': 'cltbld', 08:24:09 INFO - 'MAIL': '/var/mail/cltbld', 08:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:09 INFO - 'MOZ_NO_REMOTE': '1', 08:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:09 INFO - 'NO_EM_RESTART': '1', 08:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:09 INFO - 'PWD': '/builds/slave/test', 08:24:09 INFO - 'SHELL': '/bin/bash', 08:24:09 INFO - 'SHLVL': '1', 08:24:09 INFO - 'TERM': 'linux', 08:24:09 INFO - 'TMOUT': '86400', 08:24:09 INFO - 'USER': 'cltbld', 08:24:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:09 INFO - '_': '/tools/buildbot/bin/python'} 08:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:09 INFO - Cleaning up... 08:24:09 INFO - Return code: 0 08:24:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:24:09 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')]} 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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')]} 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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 0x7f612fd9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, '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': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', '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 08:24:09 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 08:24:09 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 08:24:09 INFO - Using env: {'DISPLAY': ':0', 08:24:09 INFO - 'HOME': '/home/cltbld', 08:24:09 INFO - 'LANG': 'en_US.UTF-8', 08:24:09 INFO - 'LANGUAGE': 'en_US:en', 08:24:09 INFO - 'LOGNAME': 'cltbld', 08:24:09 INFO - 'MAIL': '/var/mail/cltbld', 08:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:09 INFO - 'MOZ_NO_REMOTE': '1', 08:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:09 INFO - 'NO_EM_RESTART': '1', 08:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:09 INFO - 'PWD': '/builds/slave/test', 08:24:09 INFO - 'SHELL': '/bin/bash', 08:24:09 INFO - 'SHLVL': '1', 08:24:09 INFO - 'TERM': 'linux', 08:24:09 INFO - 'TMOUT': '86400', 08:24:09 INFO - 'USER': 'cltbld', 08:24:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:09 INFO - '_': '/tools/buildbot/bin/python'} 08:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:10 INFO - Downloading/unpacking flake8 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:24:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:24:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:24:12 INFO - no previously-included directories found matching 'docs/_build' 08:24:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:24:12 INFO - Running setup.py install for pep8 08:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:24:12 INFO - no previously-included directories found matching 'docs/_build' 08:24:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:24:12 INFO - Cleaning up... 08:24:13 INFO - Return code: 0 08:24:13 INFO - Running post-action listener: _resource_record_post_action 08:24:13 INFO - Running post-action listener: _start_resource_monitoring 08:24:13 INFO - Starting resource monitoring. 08:24:13 INFO - ##### 08:24:13 INFO - ##### Finished create-virtualenv step (success) 08:24:13 INFO - ##### 08:24:13 INFO - ##### 08:24:13 INFO - ##### Running install step. 08:24:13 INFO - ##### 08:24:13 INFO - Running pre-action listener: _resource_record_pre_action 08:24:13 INFO - Running main action method: install 08:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:13 INFO - Reading from file tmpfile_stdout 08:24:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:13 INFO - Reading from file tmpfile_stdout 08:24:13 INFO - Output received: 08:24:13 INFO - Usage: mozinstall [options] installer 08:24:13 INFO - Options: 08:24:13 INFO - -h, --help show this help message and exit 08:24:13 INFO - -d DEST, --destination=DEST 08:24:13 INFO - Directory to install application into. [default: 08:24:13 INFO - "/builds/slave/test"] 08:24:13 INFO - --app=APP Application being installed. [default: firefox] 08:24:13 INFO - mkdir: /builds/slave/test/build/application 08:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:24:29 INFO - Reading from file tmpfile_stdout 08:24:29 INFO - Output received: 08:24:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:29 INFO - Running post-action listener: _resource_record_post_action 08:24:29 INFO - ##### 08:24:29 INFO - ##### Finished install step (success) 08:24:29 INFO - ##### 08:24:29 INFO - ##### 08:24:29 INFO - ##### Running run-tests step. 08:24:29 INFO - ##### 08:24:29 INFO - Running pre-action listener: _resource_record_pre_action 08:24:29 INFO - Running main action method: run_tests 08:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:29 INFO - Python 2.7.3 08:24:29 INFO - Return code: 0 08:24:29 INFO - grabbing minidump binary from tooltool 08:24: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')]} 08:24:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13441c0>, '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 0x13450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1345550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:24:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:24:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:24:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:29 INFO - Return code: 0 08:24:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:24:30 INFO - Return code: 0 08:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 08:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 08:24:30 INFO - Using env: {'DISPLAY': ':0', 08:24:30 INFO - 'HOME': '/home/cltbld', 08:24:30 INFO - 'LANG': 'en_US.UTF-8', 08:24:30 INFO - 'LANGUAGE': 'en_US:en', 08:24:30 INFO - 'LOGNAME': 'cltbld', 08:24:30 INFO - 'MAIL': '/var/mail/cltbld', 08:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:30 INFO - 'MOZ_NO_REMOTE': '1', 08:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:30 INFO - 'NO_EM_RESTART': '1', 08:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:30 INFO - 'PWD': '/builds/slave/test', 08:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:30 INFO - 'SHELL': '/bin/bash', 08:24:30 INFO - 'SHLVL': '1', 08:24:30 INFO - 'TERM': 'linux', 08:24:30 INFO - 'TMOUT': '86400', 08:24:30 INFO - 'USER': 'cltbld', 08:24:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935', 08:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:30 INFO - '_': '/tools/buildbot/bin/python'} 08:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 08:24:30 INFO - mozversion application_buildid: 20160627055325 08:24:30 INFO - mozversion application_changeset: 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f 08:24:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:24:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:30 INFO - mozversion application_name: Firefox 08:24:30 INFO - mozversion application_remotingname: firefox-dev 08:24:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:30 INFO - mozversion application_vendor: Mozilla 08:24:30 INFO - mozversion application_version: 49.0a2 08:24:30 INFO - mozversion platform_buildid: 20160627055325 08:24:30 INFO - mozversion platform_changeset: 74763893c0f373a9fa4a1c61cbf9d1b49cc9bb5f 08:24:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:30 INFO - mozversion platform_version: 49.0a2 08:24:30 INFO - using testdate: 1467041070 08:24:30 INFO - actual date: 1467041070 08:24:30 INFO - starting webserver on 'localhost:48599' 08:24:30 INFO - SUITE-START | Running 2 tests 08:24:30 INFO - TEST-START | dromaeo_css 08:24:30 INFO - operating with platform_type : linux_ 08:24:30 INFO - Initialising browser for dromaeo_css test... 08:24:30 INFO - TEST-INFO | started process 29069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QjCW7/profile http://localhost:48599/getInfo.html) 08:24:34 INFO - PROCESS | 29069 | __metrics Screen width/height:1600/1200 08:24:34 INFO - PROCESS | 29069 | colorDepth:24 08:24:34 INFO - PROCESS | 29069 | Browser inner width/height: 1024/697 08:24:34 INFO - PROCESS | 29069 | __metrics 08:24:35 ERROR - PROCESS | 29069 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:24:35 INFO - PROCESS | 29069 | console.error: PushService: 08:24:35 INFO - PROCESS | 29069 | stateChangeProcessEnqueue: Error transitioning state 08:24:35 INFO - PROCESS | 29069 | UnknownError 08:24:36 INFO - TEST-INFO | 29069: exit 0 08:24:36 INFO - Browser initialized. 08:24:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:36 INFO - TEST-INFO | started process 29162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QjCW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:48 INFO - PROCESS | 29162 | RSS: Main: 145326080 08:24:48 INFO - PROCESS | 29162 | 08:25:39 INFO - PROCESS | 29162 | 1467041139682 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] 08:27:47 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48599/tests/dromaeo/cssquery-ext.html) 08:27:48 INFO - PROCESS | 29162 | RSS: Main: 255356928 08:27:48 INFO - PROCESS | 29162 | 08:30:51 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-ext.html (next: http://localhost:48599/tests/dromaeo/cssquery-jquery.html) 08:30:51 INFO - PROCESS | 29162 | RSS: Main: 231129088 08:30:51 INFO - PROCESS | 29162 | 08:33:53 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48599/tests/dromaeo/cssquery-mootools.html) 08:33:54 INFO - PROCESS | 29162 | RSS: Main: 223006720 08:33:54 INFO - PROCESS | 29162 | 08:36:56 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48599/tests/dromaeo/cssquery-prototype.html) 08:36:56 INFO - PROCESS | 29162 | RSS: Main: 219439104 08:36:56 INFO - PROCESS | 29162 | 08:39:59 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48599/tests/dromaeo/cssquery-yui.html) 08:39:59 INFO - PROCESS | 29162 | RSS: Main: 219185152 08:39:59 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | Cycle 1(1): loaded http://localhost:48599/tests/dromaeo/cssquery-yui.html (next: http://localhost:48599/tests/dromaeo/cssquery-dojo.html) 08:43:02 INFO - PROCESS | 29162 | RSS: Main: 258260992 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | __start_tp_report 08:43:02 INFO - PROCESS | 29162 | _x_x_mozilla_page_load 08:43:02 INFO - PROCESS | 29162 | _x_x_mozilla_page_load_details 08:43:02 INFO - PROCESS | 29162 | |i|pagename|runs| 08:43:02 INFO - PROCESS | 29162 | |0;dojo.html;3388.542546756188;3396.1339858336105;3416.2484253464236;3422.3326451342;3444.7244220462367;5554.666719996803;5653.1520271959225;5672.829815105543;5690.971545142279;5700.401457846923;5590.496855283024;5614.775408983635;5617.4382561743805;5626.493615574597;5639.15412688097;4875.804967801284;5071.442141364447;5076.111680455915;5107.872303192431;5155.974220128895;4957.231629097478;5041.546260836524;5074.594032477393;5078.415982162043;5080.7967681292885;5063.01271252106;5067.442581316052;5080.745962701869;5091.109055915219;5107.336046313974;5184.274201611777;5216.634835561512;5224.164133738622;5228.189630607262;5255.474452554752;4916.410030796292;4948.38145231846;4968.403791545002;5066.873328166788;5073.543381095719;5451.37309209442;5458.8908221835345;5463.890722185573;5509.696966666832;5509.696966666832;6063.834553899952;6084.452399284086;6093.146959425684;6098.2682078150465;6102.237220347457;6061.909071363933;6100.969495152496;6103.2582654527905;6113.052476866093;6127.11156882254;5713;5739.569532285095;5746.942530574641;5749.913751293734;5758.539316854642;6010.519158467312;6213.471854892295;6218.31598524162;6225.937740622536;6235.469985051231;5814.622049566765;5924.407559244041;5940.910886336708;5945.405459454107;5949.464548190684;6003.699815009232;6006.309274433409;6010.729517171738;6039.245094363205;6042.12389203563;5803.47768700819;5972.611780234271;5974.970125149346;5988.101784732325;5988.431099045583;5956.55325850563;6096.3903609639565;6097.542684298695;6097.939020609826;6137.294211165684;4630.28230624247;4631.1895418301665;4641.118187544424;4645.674802763774;4646.4191976003;3985.3822657488136;4041.959580404217;4068.5524592294823;4130.401091841666;4145.818441744089;5736.397678243808;5759.078547432391;5762.683052432073;5762.827115186551;5779.595428320062;5980.521558275327;6032.276126864805;6033.336333003366;6043.758249669964;6061.969690151521;5560.2493663355735;5655.943440565624;5714.314282286069;5735.3977832327;5758.712064396764;5042.067217564762;5043.949560504348;5046.798128074836;5050.84847454577;5051.419086805065;6282.120503129566;6291.056341548713;6293.056041593706;6298.023806309938;6301;5918.378570250062;5974.103884417372;5998.1002849572915;6024.668643224665;6089.665068421102;6253.8749225014335;6270.435660790551;6278.654673992792;6283.277423096402;6296.244450665949;5816.47651711348;5962.880742385215;5967.403259673998;5970.044792833126;6008.819735407945;5946.881062378815;5997.520198384032;6007.639541627516;6024.246969128859;6033.517318614413;5858.912116318344;5877.647341159544;5887.735051922759;5894.528437725057;5902.940970590239;5702.030654788613;5766.192733017465;5796.913046304393;5850.444207800252;5866.765329386777;5719.027765279996;5766.913496297475;5770.740316685676;5773.04744717117;5800.622959507618;5869.295684517885;5880.117982302689;5901.91147132802;5908.291005079418;5916.408359164049;5522.917156242579;5689.459501347365;5709.400512946247;5768.509676677361;5785.768569257182 08:43:02 INFO - PROCESS | 29162 | |1;ext.html;611.3275397063228;659.7031335898844;668.044696084599;669.7689297192467;672.096030838522;33231.50152747708;46177.76911115444;46693.29960050602;46749.29876051862;46818;49788;50185.24722129171;50223.24665130026;50240.748796256055;50280.24579631309;8419.115992820758;9051.63793448263;9209.447433154031;9211.355205135644;10730.19523535734;10646.041856232938;11082.390468524229;11105.333679979187;11114.277571957837;11115.44422778862;11141;11192.832107518394;11194.776104477945;11197.160212984018;11202.383868887207;8486.575671216415;10791.676249712442;11003.724906877313;11134.61028863994;11168;10621.681349559449;10988.615398461096;11031.282966607145;11040.558377664884;11051.17116216279;47416;48063.75968120137;48075;48083.75958120187;48133.75933120347;3862.4978752761963;3895.454636350913;4362.367456718758;4469.888252793674;4564.885877853047;36613.633863661285;36815.44776828323;36882;36906.44640330397;36917;4677.111348843743;4680.64895132863;4687.273472611751;4758.143534163849;4777.474477807438;424059;425133;425512;425961;426830.9999999969;35342.82328588341;35949.46075808865;72402;73162;73169.6341518289;42234.36648450276;42306.15387692229;42406.78796606059;42510.362344564855;42537.78731106387;17504.91247543754;17689.911550442164;17711.55721106957;17713.7342939856;17715.73426398605;13562.321883905764;14895.702085958437;14975.850241497663;15089.094654320776;15430.38278468871;9326.114019168168;9416.387934784218;9450.291228157916;9460.24318054554;9513.238940884712;3546.5744110706883;3551.857925682944;3568.5360903082433;3619.94570081449;3642.4718415829557;1047.3244757131608;1101.6089288302696;1111.349860331699;1200.4117982188666;1217.3061355027726;34866.82566587151;35353;35496.64503354985;35596.64403355985;35837;1208.8186771984097;1217.6712287682276;1219.3415555600054;1234.5061975209987;1241.5608763724613;17705.645887082443;18322.633547329246;18340;18426.81573184251;18546;639309;649871;650067;650140;650710;67409.32590674129;67996;67996.6600166996;68017;68039;1341.1014620204487;1385.2450414524108;1438.927998641019;1475.6901050779243;1479.9556013319618;32308.83845580757;35616.89009248526;35723.64276357203;35837.64162358447;36107.09732256715;54654.453455464936;55999;56057;56082.439175607724;56098;467359;471422;474607;475415;476344;27820.443591128467;30135.397292054473;30674.233144171576;31628.841855790575;32138.517922231655;53693.463065368844;53869.730651346494;54420;55071.449285506635;55224.72387638036;44455.77772111119;44867.737505224504;45812.770936145105;45948.540514594424;46112.53887461082;43495.13009739724;44755.552444475135;44829.41364690752;45341.54658453373;46111.53888461207;44046.559534404245;44361.77819110884;44756.32865506955;45112;45699.31451028171;38286.61713382942;39379.6062039376;39787.40318895161;40217.59782402139;40336.00095319364;29791.255218619706;29910.70089299079;29944.401111978073;29983.70016299809;30594 08:43:02 INFO - PROCESS | 29162 | |2;jquery.html;403.1916008403151;412.0666689947268;413.6483988609682;415.55950692266197;430.7221841911967;19146.808531914678;19856.90071549644;20566.794332056692;20690.586188276244;20938.790612093875;12466.189697669644;12745.490180392797;18110.4566862994;20913.47716307093;20938.37184884452;5209.114450543398;5403.756830942597;5684.516816070618;5895.292564892219;5903.527717782567;5843.386444423338;5861.062230043194;5872.324682661484;5872.9706351468185;5892.705364731768;5756.568257380693;5815.127730840365;5888.146218798293;5892.086726557391;5898.469137777599;5777.653340799566;5825.504832089277;5828.009238429478;5839.5620328475325;6177.845553861144;5626.549876009909;5723.742431590588;5749.137629355589;5755.568332375046;5759.625624334405;13589.184648920998;13773.793393099011;23168;24270.39324016896;25589.872050639813;2325.081592770846;2664.200739778078;2913.4610097131886;2936.750376218024;3047.130144716198;10142.087212150942;10629.574817007311;12010.219335743235;12265.938670306592;15258.703010244142;1907.0560072763933;1940.9421865083564;1985.9503512412161;2045.3966080006285;2072.367927782026;84974.57512712458;87292;87543.56228218818;87601.12398876058;89989.55005224998;11237.157213209042;11247.493862776195;11259.155563332783;11328.886711132784;11386.373749443861;15386.153761543223;15445.996010259298;15512.146831924352;15526.1460619667;15589.376424942875;7846.176151504124;7972.720954766555;8099.271065604006;8115.634796434175;8237.135100814448;7629.504082234637;7683.6926522939575;7713.382929365637;7750.418718596128;7785.571793551409;4697.318888761179;4763.118823017753;4860.441049279378;4863.10032643962;4872.171730805771;1806.8193180681826;1818.7180986947044;1876.2026138890917;1899.6865517189508;1909.6155287416511;956.7082039977735;1013.3514550687565;1022.4632068164274;1043.5929987304958;1071.9571217151226;19610.901945490183;20865.478363041046;20883.37349879506;20908.059137338856;20968.89515552443;1004.2066767253933;1012.1902478017556;1032.76762728387;1102.525913857049;1118.558169523034;11173.217874748852;11438.542458301576;11456.4844581994;11499.540018399337;11519.88480115188;543347;543606;551957;569819;571099;104864.47567762266;106827;107376;108280;108470;1103.1285284625055;1105.171121658756;1116.832475128721;1118.4966764955802;1123.1800785426685;17836.643267134845;18255.361062362754;18276.268949241883;18350.72473912919;18355.632887342446;40099;41786.58213417827;41916.23345168653;42096.15807683768;43967.78016110027;64040.3595964053;64154.67922660357;65317.34682653303;65623.34376656363;66459.33540664532;8723.956380218058;8973.28213742886;9150.908490915006;9400.29497787655;9483;9838.9016109838;9996.850047249443;11063.944680276547;14669.70660586761;14760.852391475948;12540.811887821872;12831.679208019874;12841.293728845003;12977.675558111123;13058.738825223252;12424;12822.807657884952;12882.935585322013;12888.291143986795;12951.481940722642;10082.092611664986;12810.295433751233;12932.676683082998;12978.156419832681;13100.213987160801;7700.653470593725;8937.553122343726;9083.545822708971;9275.118863707938;9441.386309889835;11232.943835280772;12838;12858.807117893426;13000.479980800663;13127.540536081191 08:43:02 INFO - PROCESS | 29162 | |3;mootools.html;1374.2098293481238;1551.5190291009785;1568.5529624057144;1676.7736355591999;1769.5133838194495;9050.90949090509;9419.858702119465;9428.245740340773;9694.12752852245;9698.612055517788;9400;9574.2340612751;9583.233341332694;9586.089321514462;9593.136617704406;2185.803277705006;2445.498672772086;2464.950700985975;2493.0401795308753;2522.2685421227916;2513.5852584323566;2530.8987640494356;2532.556802559554;2533.1767175667887;2537.8731063446753;2493.7381574934643;2509.5482813093636;2510.297116807297;2512.560301947161;2512.6482292478977;2062.9690554641693;2133.7332833395826;2133.775953524889;2309.1571576374504;2428.040923835084;2438.7195472520534;2445.2419749877595;2451.6935383077116;2451.705795304557;2457.1154384421593;9108.635654573809;9145.725628231165;9156.8626470603;9159.725208243763;9171.266298696088;5405.8107966221;5519.337679478448;5528.143137813645;5537.612367134302;5540;3425.4519276915576;3476.5132881396626;3589.73077019222;3593.7304702147444;3643.508126402928;1202.41081869884;1203.2840459926417;1211.5275042733342;1222.9021678265717;1224.0574757436814;13269;13319.53381631648;13338.13302135358;13341.266230357327;13354.732905341936;4850.369451971221;4882.536159064884;4987.850364489072;4993.726599717049;5012.523810238022;11118.277311974858;11147.108231341474;11165.330080195214;11173.05029072538;11185;5664.716764161775;5673.744681489343;5674.120511320752;5674.26234589509;5678;4537.478190008125;5044.873878153002;5143.382794064736;5147.099257629975;5254.369475662868;4363.061941682554;4379.430674012422;4398.406215160976;4453.487848897354;4463.24124898768;1375.5116933488669;1383.8131852200027;1417.4054189037333;1434.3688776938113;1441.891858110625;980.5097451274363;1013.8175128476797;1021.8569400283966;1028.9176865850714;1083.128081894083;6541.934580654228;6604.240512341143;6604.537682362188;6633.867322653617;6814.1482314710665;459.7333546542997;463.83533845485044;468.83825080347225;468.9015306785545;469.317143556125;4687.554682305175;4755.476897541268;4837.685550439211;4840.540148685869;4885.5847252983895;11769.646910592524;12169.574064907685;12185.207961482476;12508.562200322946;12520.31138287403;12308.138430309793;12328.137030407965;12347.6913077172;12362.567310144103;12375.319357435428;8765.780855478664;8784.077671844492;8935.329850261256;8939.553022348857;8970.596323165342;6500.382463665944;6625.304343044104;6636.767713130017;6831.521793474409;6876.965615171892;10592.788144236918;10616.309939853885;10952.835707464235;10981.560737570408;11007.174461915549;10923.12614990783;10979.780404392028;10984.395858227874;10991.780164396827;11073.83389249178;7795.649195786316;8027.919720802717;8166.7958301042945;8711.91288087111;8894.4663320201;8992.955035225044;9006.954965225132;9017.684381046894;9050.185483306534;9075;7862.253085956825;8039.276465118168;8088.110307866013;8183.73152161416;8227.588620569068;7932.801679958047;8096.109427963037;8246.546439945621;8369.414141010071;8496.235338819535;7513.4740568159705;7528.51064680794;7644.770656880302;7660.5403675779635;7675.731349402744;5866.656026016349;5926.2295901532525;5980.551458640706;6030.185924900258;6049.3950604939155;5637.520810731134;5734.283214598176;5891.1752354669525;5972.134040564007;6042.969785151046 08:43:02 INFO - PROCESS | 29162 | |4;prototype.html;352.5012107867368;361.24319550541617;365.9835307411166;372.32237328062934;373.70664028737446;5379.488948549892;5462.781488740446;5545.279113715216;5572;5589.972050139749;5452.91820622691;5462.672239665623;5478.397376288605;5478.616496845222;5514.172874068891;4312.913741725163;4336.544662810406;4358.760268185249;4362.498312694049;4376.168527979674;3988.361862102064;4040.616141466556;4314.245007123756;4367.54140815213;4372.8032238549185;4245.596668316521;4262.46719160105;4272.722273052257;4283.528811830696;4302.462192225972;4263.211305908417;4264.336908605646;4275.123599662062;4283.97858010711;4302.139572085564;3740.4576336431337;3806.7525610835482;3849.4610754494115;3852.8073596320073;3863.903402414934;5213.540208741559;5239.633225674204;5241.685498870042;5283.445238249967;5302.92045619316;4833.516648335173;4900.191468407708;4911.4106307243;4919.163742163841;4920;5563.693996830173;5736.569757268222;5754.165645981351;5778.479936805707;5788.652680839163;4155;4193.370994350841;4196.4964204295375;4196.643285320752;4204.4653701399075;5890.646561206341;5971.820845374646;5995.910061349084;6011.098335249704;6031.879362412771;4271.402003719481;4271.530131685512;4279.358096285582;4290.206311832321;4292.862391466201;4344.174606824693;4344.218040752632;4344.782760862007;4355.564443555619;4358.825646974085;4916.640012793879;4917.631177661689;4938.358013458227;4946.678465899777;4967.105920934194;5673.858153546194;5800.680962547016;5822.030764310232;5834.474897259267;5836.9124463133085;1404.859514048587;1441.4306348992088;1486.1900264355952;1513.3265696764834;1514.871235944957;949.4493193947494;962.7063745557672;970.4225985538593;974.4543055888724;974.8245315843075;5010.173321401928;5108.412532558729;5116.360454943132;5119.0017946500075;5136.948630513647;5246.501582349671;5258;5279.788808447619;5344.225087362389;5362.498500419889;4733.739644319596;4983.451820299764;5005.224190250517;5007.84976450707;5059.696418214919;2802.3694668699786;2802.8598570071413;2804.5652923796843;2817.7464028237146;2823.788215883817;5303.310569625924;5309.230161626542;5355.812546560852;5392.379876314196;5432.6468779529205;5061.469265367316;5204.22476698778;5323.946760532345;5367.892642147135;5384.488473595002;5406.1887818335035;5407.621466497386;5446.863828404401;5467.699276539828;5475.206095116186;5261.763220655003;5348.946510535001;5355.955588660329;5370.140777475585;5379.784808607768;4952.47998960104;5277.366715994105;5291.068759902685;5293.2854064702315;5325.281087053353;5392.730363481732;5422.728863556886;5449.209864569694;5510.952918945388;5524.762471199171;3912.628300311466;3942.566317704993;3947.8223479944045;3967.2065586882163;3979.602039796113;4981.925271120864;5279.762410691605;5285.867853303698;5684.5556410743775;5846.41535846412;5680.318361796611;5686.545076393796;5704.543636509153;5710.486056254791;5809.228185403493;5703.828885133453;5714.79998200061;5743.282089738783;5749.958764638493;5764.510016648464;5595.720213989365;5643.0249412705225;5677.68772717488;5680.602357834912;5722.713864306851;5729.71351432435;5758.971205143947;5760.917908918708;5768.798092066925;5800.187973683604;5470.56235501151;5689.829305120853;5721.771129154788;5724.3703192647945;5740 08:43:02 INFO - PROCESS | 29162 | |5;yui.html;842.8356470488258;869.6651789061211;883.3816328570002;884.694780300796;895.7312806158153;15225.086494810304;16259.756103658454;16317.510474685749;16320.510384688478;16358.918205408956;15467.381304747796;15701.214939253021;15705.371785128582;15716.135612541306;15720.213989300517;735.2133217457323;852.4544291653347;862.8964524257067;874.4403581707712;885.7387070814093;878.9428687135347;883.2845395229853;885.3713863157134;886.7960369115075;889.4440974391006;930.4463844012802;939.0797018921461;939.2673714502699;939.3049143633696;939.6476321379482;777.8872063550782;913.5112714697638;927;929.9442033478012;932.2868005975434;683.7470136049644;685.1606781692436;685.3112621815044;685.9108315918949;686.2691233835999;15809.92095039529;15869.285882135217;15930.920345398315;15936.920315398465;15943.601409964727;15503.689926201412;15574.454894078766;15608.687826243526;15652.921735391365;15739.92130039354;13495.325233738275;13583;13624.318784060757;13639.386227619781;13677.589672309847;4682.29765535169;4715.481297057355;4718.528147185289;4793.688410253322;4814.10938976287;79115.81326280053;79222.20777792264;80318.59840700818;80700.59649701773;80705.59647201785;12300.630981070582;12341.13612047166;12522.749545009048;12573.119881608383;12680.23918564889;22318.888405557867;22329.106835726714;22348.888255558617;22364.776352236593;22379.216727414463;9135.360524763202;9263.76840578991;9596.136347728738;9707.9029209707;9718.854217186748;4993.725345105981;5006.3992320921725;5197.272381866542;5228.37259528859;5244.108501554745;3550.485179648988;3663.7435379523176;3668;3672.2288319453214;3673.7612055216327;632.2539403503818;659.1069101367674;697.2852825853439;700.9088818453569;713.2368365848492;721.8736721073897;839.8152406470567;845.8646616541324;854.1927878155084;860.2902605350611;11512.481938312796;11552.364619945816;11684.771756060572;11803.17377783564;11846;669.4911866981032;789.7235967411475;790.9841803163904;809.6842231529708;832.342449464916;5270.552003079704;5412.827605420765;5443.319585051869;5497.47773961473;5521.69630670317;109538;124246;126172.36913815372;130403;133743;108490;112417.25496470074;112436.49502440394;113057;113211;98471;102270;103610.48194758978;104230;107000.92999070065;9832.803343933225;10225.642102526375;10235.846462302923;10371.325863818827;10411.427371494641;57817.710911445174;58334.4166558346;58632;58723.41276587179;59510.40489595049;81120;82791.58604206941;83153.58423207846;84686;84985.15014849772;12885.742285154058;12972.545960891324;13207.471701131846;13331.866681333062;13556.86443135556;12042.337671428155;14373.496927607484;15329.923350383177;15716.292766825749;16069.598260043593;13130.343482826012;14294.285285735463;15128.773068403763;16524.504264872074;16525;13104.344782760632;13916.956228282717;15111.697766044837;15458.613534661723;15773.842261577238;13405.262710551013;13818.309084545934;13929.651758706113;14004.089734167246;14054.648633784238;12498.500059997497;12554.246745195318;12678.87321126777;12962.092653514164;13013.284269365276;12677.429515671633;12789.872101279241;12813.93593032029;13020.9583233343;13139.54011609589 08:43:02 INFO - PROCESS | 29162 | __end_tp_report 08:43:02 INFO - PROCESS | 29162 | __start_cc_report 08:43:02 INFO - PROCESS | 29162 | _x_x_mozilla_cycle_collect,871 08:43:02 INFO - PROCESS | 29162 | __end_cc_report 08:43:02 INFO - PROCESS | 29162 | __startTimestamp1467042182721__endTimestamp 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | ------- Summary: start ------- 08:43:02 INFO - PROCESS | 29162 | Number of tests: 6 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#0] dojo.html Cycles:165 Average:5588.71 Median:5770.74 stddev:632.27 (11.0%) stddev-sans-first:610.20 08:43:02 INFO - PROCESS | 29162 | Values: 3388.5 3396.1 3416.2 3422.3 3444.7 5554.7 5653.2 5672.8 5691.0 5700.4 5590.5 5614.8 5617.4 5626.5 5639.2 4875.8 5071.4 5076.1 5107.9 5156.0 4957.2 5041.5 5074.6 5078.4 5080.8 5063.0 5067.4 5080.7 5091.1 5107.3 5184.3 5216.6 5224.2 5228.2 5255.5 4916.4 4948.4 4968.4 5066.9 5073.5 5451.4 5458.9 5463.9 5509.7 5509.7 6063.8 6084.5 6093.1 6098.3 6102.2 6061.9 6101.0 6103.3 6113.1 6127.1 5713.0 5739.6 5746.9 5749.9 5758.5 6010.5 6213.5 6218.3 6225.9 6235.5 5814.6 5924.4 5940.9 5945.4 5949.5 6003.7 6006.3 6010.7 6039.2 6042.1 5803.5 5972.6 5975.0 5988.1 5988.4 5956.6 6096.4 6097.5 6097.9 6137.3 4630.3 4631.2 4641.1 4645.7 4646.4 3985.4 4042.0 4068.6 4130.4 4145.8 5736.4 5759.1 5762.7 5762.8 5779.6 5980.5 6032.3 6033.3 6043.8 6062.0 5560.2 5655.9 5714.3 5735.4 5758.7 5042.1 5043.9 5046.8 5050.8 5051.4 6282.1 6291.1 6293.1 6298.0 6301.0 5918.4 5974.1 5998.1 6024.7 6089.7 6253.9 6270.4 6278.7 6283.3 6296.2 5816.5 5962.9 5967.4 5970.0 6008.8 5946.9 5997.5 6007.6 6024.2 6033.5 5858.9 5877.6 5887.7 5894.5 5902.9 5702.0 5766.2 5796.9 5850.4 5866.8 5719.0 5766.9 5770.7 5773.0 5800.6 5869.3 5880.1 5901.9 5908.3 5916.4 5522.9 5689.5 5709.4 5768.5 5785.8 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#1] ext.html Cycles:180 Average:67774.21 Median:42270.26 stddev:139560.20 (330.2%) stddev-sans-first:139860.60 08:43:02 INFO - PROCESS | 29162 | Values: 611.3 659.7 668.0 669.8 672.1 33231.5 46177.8 46693.3 46749.3 46818.0 49788.0 50185.2 50223.2 50240.7 50280.2 8419.1 9051.6 9209.4 9211.4 10730.2 10646.0 11082.4 11105.3 11114.3 11115.4 11141.0 11192.8 11194.8 11197.2 11202.4 8486.6 10791.7 11003.7 11134.6 11168.0 10621.7 10988.6 11031.3 11040.6 11051.2 47416.0 48063.8 48075.0 48083.8 48133.8 3862.5 3895.5 4362.4 4469.9 4564.9 36613.6 36815.4 36882.0 36906.4 36917.0 4677.1 4680.6 4687.3 4758.1 4777.5 424059.0 425133.0 425512.0 425961.0 426831.0 35342.8 35949.5 72402.0 73162.0 73169.6 42234.4 42306.2 42406.8 42510.4 42537.8 17504.9 17689.9 17711.6 17713.7 17715.7 13562.3 14895.7 14975.9 15089.1 15430.4 9326.1 9416.4 9450.3 9460.2 9513.2 3546.6 3551.9 3568.5 3619.9 3642.5 1047.3 1101.6 1111.3 1200.4 1217.3 34866.8 35353.0 35496.6 35596.6 35837.0 1208.8 1217.7 1219.3 1234.5 1241.6 17705.6 18322.6 18340.0 18426.8 18546.0 639309.0 649871.0 650067.0 650140.0 650710.0 67409.3 67996.0 67996.7 68017.0 68039.0 1341.1 1385.2 1438.9 1475.7 1480.0 32308.8 35616.9 35723.6 35837.6 36107.1 54654.5 55999.0 56057.0 56082.4 56098.0 467359.0 471422.0 474607.0 475415.0 476344.0 27820.4 30135.4 30674.2 31628.8 32138.5 53693.5 53869.7 54420.0 55071.4 55224.7 44455.8 44867.7 45812.8 45948.5 46112.5 43495.1 44755.6 44829.4 45341.5 46111.5 44046.6 44361.8 44756.3 45112.0 45699.3 38286.6 39379.6 39787.4 40217.6 40336.0 29791.3 29910.7 29944.4 29983.7 30594.0 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#2] jquery.html Cycles:180 Average:31796.61 Median:20925.92 stddev:91821.62 (438.8%) stddev-sans-first:92048.95 08:43:02 INFO - PROCESS | 29162 | Values: 403.2 412.1 413.6 415.6 430.7 19146.8 19856.9 20566.8 20690.6 20938.8 12466.2 12745.5 18110.5 20913.5 20938.4 5209.1 5403.8 5684.5 5895.3 5903.5 5843.4 5861.1 5872.3 5873.0 5892.7 5756.6 5815.1 5888.1 5892.1 5898.5 5777.7 5825.5 5828.0 5839.6 6177.8 5626.5 5723.7 5749.1 5755.6 5759.6 13589.2 13773.8 23168.0 24270.4 25589.9 2325.1 2664.2 2913.5 2936.8 3047.1 10142.1 10629.6 12010.2 12265.9 15258.7 1907.1 1940.9 1986.0 2045.4 2072.4 84974.6 87292.0 87543.6 87601.1 89989.6 11237.2 11247.5 11259.2 11328.9 11386.4 15386.2 15446.0 15512.1 15526.1 15589.4 7846.2 7972.7 8099.3 8115.6 8237.1 7629.5 7683.7 7713.4 7750.4 7785.6 4697.3 4763.1 4860.4 4863.1 4872.2 1806.8 1818.7 1876.2 1899.7 1909.6 956.7 1013.4 1022.5 1043.6 1072.0 19610.9 20865.5 20883.4 20908.1 20968.9 1004.2 1012.2 1032.8 1102.5 1118.6 11173.2 11438.5 11456.5 11499.5 11519.9 543347.0 543606.0 551957.0 569819.0 571099.0 104864.5 106827.0 107376.0 108280.0 108470.0 1103.1 1105.2 1116.8 1118.5 1123.2 17836.6 18255.4 18276.3 18350.7 18355.6 40099.0 41786.6 41916.2 42096.2 43967.8 64040.4 64154.7 65317.3 65623.3 66459.3 8724.0 8973.3 9150.9 9400.3 9483.0 9838.9 9996.9 11063.9 14669.7 14760.9 12540.8 12831.7 12841.3 12977.7 13058.7 12424.0 12822.8 12882.9 12888.3 12951.5 10082.1 12810.3 12932.7 12978.2 13100.2 7700.7 8937.6 9083.5 9275.1 9441.4 11232.9 12838.0 12858.8 13000.5 13127.5 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#3] mootools.html Cycles:180 Average:6279.62 Median:2612.40 stddev:3625.74 (138.8%) stddev-sans-first:3617.17 08:43:02 INFO - PROCESS | 29162 | Values: 1374.2 1551.5 1568.6 1676.8 1769.5 9050.9 9419.9 9428.2 9694.1 9698.6 9400.0 9574.2 9583.2 9586.1 9593.1 2185.8 2445.5 2465.0 2493.0 2522.3 2513.6 2530.9 2532.6 2533.2 2537.9 2493.7 2509.5 2510.3 2512.6 2512.6 2063.0 2133.7 2133.8 2309.2 2428.0 2438.7 2445.2 2451.7 2451.7 2457.1 9108.6 9145.7 9156.9 9159.7 9171.3 5405.8 5519.3 5528.1 5537.6 5540.0 3425.5 3476.5 3589.7 3593.7 3643.5 1202.4 1203.3 1211.5 1222.9 1224.1 13269.0 13319.5 13338.1 13341.3 13354.7 4850.4 4882.5 4987.9 4993.7 5012.5 11118.3 11147.1 11165.3 11173.1 11185.0 5664.7 5673.7 5674.1 5674.3 5678.0 4537.5 5044.9 5143.4 5147.1 5254.4 4363.1 4379.4 4398.4 4453.5 4463.2 1375.5 1383.8 1417.4 1434.4 1441.9 980.5 1013.8 1021.9 1028.9 1083.1 6541.9 6604.2 6604.5 6633.9 6814.1 459.7 463.8 468.8 468.9 469.3 4687.6 4755.5 4837.7 4840.5 4885.6 11769.6 12169.6 12185.2 12508.6 12520.3 12308.1 12328.1 12347.7 12362.6 12375.3 8765.8 8784.1 8935.3 8939.6 8970.6 6500.4 6625.3 6636.8 6831.5 6877.0 10592.8 10616.3 10952.8 10981.6 11007.2 10923.1 10979.8 10984.4 10991.8 11073.8 7795.6 8027.9 8166.8 8711.9 8894.5 8993.0 9007.0 9017.7 9050.2 9075.0 7862.3 8039.3 8088.1 8183.7 8227.6 7932.8 8096.1 8246.5 8369.4 8496.2 7513.5 7528.5 7644.8 7660.5 7675.7 5866.7 5926.2 5980.6 6030.2 6049.4 5637.5 5734.3 5891.2 5972.1 6043.0 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#4] prototype.html Cycles:180 Average:4675.53 Median:5278.56 stddev:1335.62 (25.3%) stddev-sans-first:1299.36 08:43:02 INFO - PROCESS | 29162 | Values: 352.5 361.2 366.0 372.3 373.7 5379.5 5462.8 5545.3 5572.0 5590.0 5452.9 5462.7 5478.4 5478.6 5514.2 4312.9 4336.5 4358.8 4362.5 4376.2 3988.4 4040.6 4314.2 4367.5 4372.8 4245.6 4262.5 4272.7 4283.5 4302.5 4263.2 4264.3 4275.1 4284.0 4302.1 3740.5 3806.8 3849.5 3852.8 3863.9 5213.5 5239.6 5241.7 5283.4 5302.9 4833.5 4900.2 4911.4 4919.2 4920.0 5563.7 5736.6 5754.2 5778.5 5788.7 4155.0 4193.4 4196.5 4196.6 4204.5 5890.6 5971.8 5995.9 6011.1 6031.9 4271.4 4271.5 4279.4 4290.2 4292.9 4344.2 4344.2 4344.8 4355.6 4358.8 4916.6 4917.6 4938.4 4946.7 4967.1 5673.9 5800.7 5822.0 5834.5 5836.9 1404.9 1441.4 1486.2 1513.3 1514.9 949.4 962.7 970.4 974.5 974.8 5010.2 5108.4 5116.4 5119.0 5136.9 5246.5 5258.0 5279.8 5344.2 5362.5 4733.7 4983.5 5005.2 5007.8 5059.7 2802.4 2802.9 2804.6 2817.7 2823.8 5303.3 5309.2 5355.8 5392.4 5432.6 5061.5 5204.2 5323.9 5367.9 5384.5 5406.2 5407.6 5446.9 5467.7 5475.2 5261.8 5348.9 5356.0 5370.1 5379.8 4952.5 5277.4 5291.1 5293.3 5325.3 5392.7 5422.7 5449.2 5511.0 5524.8 3912.6 3942.6 3947.8 3967.2 3979.6 4981.9 5279.8 5285.9 5684.6 5846.4 5680.3 5686.5 5704.5 5710.5 5809.2 5703.8 5714.8 5743.3 5750.0 5764.5 5595.7 5643.0 5677.7 5680.6 5722.7 5729.7 5759.0 5760.9 5768.8 5800.2 5470.6 5689.8 5721.8 5724.4 5740.0 08:43:02 INFO - PROCESS | 29162 | 08:43:02 INFO - PROCESS | 29162 | [#5] yui.html Cycles:180 Average:23011.99 Median:22356.83 stddev:33497.89 (149.8%) stddev-sans-first:33550.50 08:43:02 INFO - PROCESS | 29162 | Values: 842.8 869.7 883.4 884.7 895.7 15225.1 16259.8 16317.5 16320.5 16358.9 15467.4 15701.2 15705.4 15716.1 15720.2 735.2 852.5 862.9 874.4 885.7 878.9 883.3 885.4 886.8 889.4 930.4 939.1 939.3 939.3 939.6 777.9 913.5 927.0 929.9 932.3 683.7 685.2 685.3 685.9 686.3 15809.9 15869.3 15930.9 15936.9 15943.6 15503.7 15574.5 15608.7 15652.9 15739.9 13495.3 13583.0 13624.3 13639.4 13677.6 4682.3 4715.5 4718.5 4793.7 4814.1 79115.8 79222.2 80318.6 80700.6 80705.6 12300.6 12341.1 12522.7 12573.1 12680.2 22318.9 22329.1 22348.9 22364.8 22379.2 9135.4 9263.8 9596.1 9707.9 9718.9 4993.7 5006.4 5197.3 5228.4 5244.1 3550.5 3663.7 3668.0 3672.2 3673.8 632.3 659.1 697.3 700.9 713.2 721.9 839.8 845.9 854.2 860.3 11512.5 11552.4 11684.8 11803.2 11846.0 669.5 789.7 791.0 809.7 832.3 5270.6 5412.8 5443.3 5497.5 5521.7 109538.0 124246.0 126172.4 130403.0 133743.0 108490.0 112417.3 112436.5 113057.0 113211.0 98471.0 102270.0 103610.5 104230.0 107000.9 9832.8 10225.6 10235.8 10371.3 10411.4 57817.7 58334.4 58632.0 58723.4 59510.4 81120.0 82791.6 83153.6 84686.0 84985.2 12885.7 12972.5 13207.5 13331.9 13556.9 12042.3 14373.5 15329.9 15716.3 16069.6 13130.3 14294.3 15128.8 16524.5 16525.0 13104.3 13917.0 15111.7 15458.6 15773.8 13405.3 13818.3 13929.7 14004.1 14054.6 12498.5 12554.2 12678.9 12962.1 13013.3 12677.4 12789.9 12813.9 13021.0 13139.5 08:43:02 INFO - PROCESS | 29162 | -------- Summary: end -------- 08:43:02 INFO - PROCESS | 29162 | 08:43:03 INFO - TEST-INFO | 29162: exit 0 08:43:03 INFO - TEST-OK | dromaeo_css | took 1113006ms 08:43:03 INFO - TEST-START | kraken 08:43:03 INFO - operating with platform_type : linux_ 08:43:03 INFO - Initialising browser for kraken test... 08:43:03 INFO - TEST-INFO | started process 29350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpECi5a9/profile http://localhost:48599/getInfo.html) 08:43:07 INFO - PROCESS | 29350 | __metrics Screen width/height:1600/1200 08:43:07 INFO - PROCESS | 29350 | colorDepth:24 08:43:07 INFO - PROCESS | 29350 | Browser inner width/height: 1024/697 08:43:07 INFO - PROCESS | 29350 | __metrics 08:43:08 ERROR - PROCESS | 29350 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:08 INFO - PROCESS | 29350 | console.error: PushService: 08:43:08 INFO - PROCESS | 29350 | stateChangeProcessEnqueue: Error transitioning state 08:43:08 INFO - PROCESS | 29350 | UnknownError 08:43:09 INFO - TEST-INFO | 29350: exit 0 08:43:09 INFO - Browser initialized. 08:43:09 INFO - Running cycle 1/1 for kraken test... 08:43:09 INFO - TEST-INFO | started process 29441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpECi5a9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:21 INFO - PROCESS | 29441 | RSS: Main: 145489920 08:43:21 INFO - PROCESS | 29441 | 08:43:23 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48599/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:24 INFO - PROCESS | 29441 | RSS: Main: 194072576 08:43:24 INFO - PROCESS | 29441 | 08:43:27 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48599/tests/kraken/driver.html?testName=audio-dft) 08:43:27 INFO - PROCESS | 29441 | RSS: Main: 192495616 08:43:27 INFO - PROCESS | 29441 | 08:43:30 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48599/tests/kraken/driver.html?testName=audio-fft) 08:43:31 INFO - PROCESS | 29441 | RSS: Main: 279379968 08:43:31 INFO - PROCESS | 29441 | 08:43:33 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48599/tests/kraken/driver.html?testName=audio-oscillator) 08:43:33 INFO - PROCESS | 29441 | RSS: Main: 187248640 08:43:33 INFO - PROCESS | 29441 | 08:43:36 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:36 INFO - PROCESS | 29441 | RSS: Main: 187899904 08:43:36 INFO - PROCESS | 29441 | 08:43:39 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48599/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:40 INFO - PROCESS | 29441 | RSS: Main: 222834688 08:43:40 INFO - PROCESS | 29441 | 08:43:43 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48599/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:44 INFO - PROCESS | 29441 | RSS: Main: 221925376 08:43:44 INFO - PROCESS | 29441 | 08:43:47 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48599/tests/kraken/driver.html?testName=json-parse-financial) 08:43:47 INFO - PROCESS | 29441 | RSS: Main: 222556160 08:43:47 INFO - PROCESS | 29441 | 08:43:49 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:49 INFO - PROCESS | 29441 | RSS: Main: 200904704 08:43:49 INFO - PROCESS | 29441 | 08:43:51 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:52 INFO - PROCESS | 29441 | RSS: Main: 201162752 08:43:52 INFO - PROCESS | 29441 | 08:43:54 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:54 INFO - PROCESS | 29441 | RSS: Main: 209543168 08:43:54 INFO - PROCESS | 29441 | 08:43:57 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:57 INFO - PROCESS | 29441 | RSS: Main: 212652032 08:43:57 INFO - PROCESS | 29441 | 08:44:00 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:01 INFO - PROCESS | 29441 | RSS: Main: 210649088 08:44:01 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | Cycle 1(1): loaded http://localhost:48599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48599/tests/kraken/driver.html?testName=ai-astar) 08:44:02 INFO - PROCESS | 29441 | RSS: Main: 252575744 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | __start_tp_report 08:44:02 INFO - PROCESS | 29441 | _x_x_mozilla_page_load 08:44:02 INFO - PROCESS | 29441 | _x_x_mozilla_page_load_details 08:44:02 INFO - PROCESS | 29441 | |i|pagename|runs| 08:44:02 INFO - PROCESS | 29441 | |0;ai-astar;110;103;110;109;110;110;110;111;110;110 08:44:02 INFO - PROCESS | 29441 | |1;audio-beat-detection;162;125;125;182;126;132;146;123;165;124 08:44:02 INFO - PROCESS | 29441 | |2;audio-dft;161;161;161;160;160;160;161;160;159;162 08:44:02 INFO - PROCESS | 29441 | |3;audio-fft;73;74;74;125;74;76;75;74;100;75 08:44:02 INFO - PROCESS | 29441 | |4;audio-oscillator;85;85;112;84;85;84;114;85;85;135 08:44:02 INFO - PROCESS | 29441 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;116;116 08:44:02 INFO - PROCESS | 29441 | |6;imaging-darkroom;145;145;147;145;146;145;146;145;146;145 08:44:02 INFO - PROCESS | 29441 | |7;imaging-desaturate;95;94;95;96;94;95;95;95;95;95 08:44:02 INFO - PROCESS | 29441 | |8;json-parse-financial;51;51;51;51;52;52;53;53;51;53 08:44:02 INFO - PROCESS | 29441 | |9;json-stringify-tinderbox;59;60;60;60;59;60;59;59;59;59 08:44:02 INFO - PROCESS | 29441 | |10;stanford-crypto-aes;82;80;76;76;76;77;76;76;108;76 08:44:02 INFO - PROCESS | 29441 | |11;stanford-crypto-ccm;127;127;131;114;114;115;124;125;127;133 08:44:02 INFO - PROCESS | 29441 | |12;stanford-crypto-pbkdf2;155;157;155;159;150;151;154;152;151;150 08:44:02 INFO - PROCESS | 29441 | |13;stanford-crypto-sha256-iterative;61;60;62;66;61;65;60;61;63;62 08:44:02 INFO - PROCESS | 29441 | __end_tp_report 08:44:02 INFO - PROCESS | 29441 | __start_cc_report 08:44:02 INFO - PROCESS | 29441 | _x_x_mozilla_cycle_collect,1542 08:44:02 INFO - PROCESS | 29441 | __end_cc_report 08:44:02 INFO - PROCESS | 29441 | __startTimestamp1467042242925__endTimestamp 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | ------- Summary: start ------- 08:44:02 INFO - PROCESS | 29441 | Number of tests: 14 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.26 (2.1%) stddev-sans-first:2.39 08:44:02 INFO - PROCESS | 29441 | Values: 110.0 103.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:139.00 stddev:21.48 (15.5%) stddev-sans-first:21.40 08:44:02 INFO - PROCESS | 29441 | Values: 162.0 125.0 125.0 182.0 126.0 132.0 146.0 123.0 165.0 124.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 08:44:02 INFO - PROCESS | 29441 | Values: 161.0 161.0 161.0 160.0 160.0 160.0 161.0 160.0 159.0 162.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:17.14 (23.2%) stddev-sans-first:17.87 08:44:02 INFO - PROCESS | 29441 | Values: 73.0 74.0 74.0 125.0 74.0 76.0 75.0 74.0 100.0 75.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:18.23 (21.4%) stddev-sans-first:18.94 08:44:02 INFO - PROCESS | 29441 | Values: 85.0 85.0 112.0 84.0 85.0 84.0 114.0 85.0 85.0 135.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:44:02 INFO - PROCESS | 29441 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:44:02 INFO - PROCESS | 29441 | Values: 145.0 145.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:44:02 INFO - PROCESS | 29441 | Values: 95.0 94.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 08:44:02 INFO - PROCESS | 29441 | Values: 51.0 51.0 51.0 51.0 52.0 52.0 53.0 53.0 51.0 53.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:44:02 INFO - PROCESS | 29441 | Values: 59.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:76.00 stddev:9.96 (13.1%) stddev-sans-first:10.54 08:44:02 INFO - PROCESS | 29441 | Values: 82.0 80.0 76.0 76.0 76.0 77.0 76.0 76.0 108.0 76.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:127.00 stddev:6.98 (5.5%) stddev-sans-first:7.30 08:44:02 INFO - PROCESS | 29441 | Values: 127.0 127.0 131.0 114.0 114.0 115.0 124.0 125.0 127.0 133.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:3.10 (2.0%) stddev-sans-first:3.23 08:44:02 INFO - PROCESS | 29441 | Values: 155.0 157.0 155.0 159.0 150.0 151.0 154.0 152.0 151.0 150.0 08:44:02 INFO - PROCESS | 29441 | 08:44:02 INFO - PROCESS | 29441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.02 (3.3%) stddev-sans-first:2.11 08:44:02 INFO - PROCESS | 29441 | Values: 61.0 60.0 62.0 66.0 61.0 65.0 60.0 61.0 63.0 62.0 08:44:02 INFO - PROCESS | 29441 | -------- Summary: end -------- 08:44:02 INFO - PROCESS | 29441 | 08:44:03 INFO - TEST-INFO | 29441: exit 0 08:44:03 INFO - TEST-OK | kraken | took 60420ms 08:44:03 INFO - SUITE-END | took 1173s 08:44:04 INFO - Completed test suite (00:19:33) 08:44:04 INFO - javascript benchmark 08:44:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.542546756188, 3396.1339858336105, 3416.2484253464236, 3422.3326451342, 3444.7244220462367, 5554.666719996803, 5653.1520271959225, 5672.829815105543, 5690.971545142279, 5700.401457846923, 5590.496855283024, 5614.775408983635, 5617.4382561743805, 5626.493615574597, 5639.15412688097, 4875.804967801284, 5071.442141364447, 5076.111680455915, 5107.872303192431, 5155.974220128895, 4957.231629097478, 5041.546260836524, 5074.594032477393, 5078.415982162043, 5080.7967681292885, 5063.01271252106, 5067.442581316052, 5080.745962701869, 5091.109055915219, 5107.336046313974, 5184.274201611777, 5216.634835561512, 5224.164133738622, 5228.189630607262, 5255.474452554752, 4916.410030796292, 4948.38145231846, 4968.403791545002, 5066.873328166788, 5073.543381095719, 5451.37309209442, 5458.8908221835345, 5463.890722185573, 5509.696966666832, 5509.696966666832, 6063.834553899952, 6084.452399284086, 6093.146959425684, 6098.2682078150465, 6102.237220347457, 6061.909071363933, 6100.969495152496, 6103.2582654527905, 6113.052476866093, 6127.11156882254, 5713.0, 5739.569532285095, 5746.942530574641, 5749.913751293734, 5758.539316854642, 6010.519158467312, 6213.471854892295, 6218.31598524162, 6225.937740622536, 6235.469985051231, 5814.622049566765, 5924.407559244041, 5940.910886336708, 5945.405459454107, 5949.464548190684, 6003.699815009232, 6006.309274433409, 6010.729517171738, 6039.245094363205, 6042.12389203563, 5803.47768700819, 5972.611780234271, 5974.970125149346, 5988.101784732325, 5988.431099045583, 5956.55325850563, 6096.3903609639565, 6097.542684298695, 6097.939020609826, 6137.294211165684, 4630.28230624247, 4631.1895418301665, 4641.118187544424, 4645.674802763774, 4646.4191976003, 3985.3822657488136, 4041.959580404217, 4068.5524592294823, 4130.401091841666, 4145.818441744089, 5736.397678243808, 5759.078547432391, 5762.683052432073, 5762.827115186551, 5779.595428320062, 5980.521558275327, 6032.276126864805, 6033.336333003366, 6043.758249669964, 6061.969690151521, 5560.2493663355735, 5655.943440565624, 5714.314282286069, 5735.3977832327, 5758.712064396764, 5042.067217564762, 5043.949560504348, 5046.798128074836, 5050.84847454577, 5051.419086805065, 6282.120503129566, 6291.056341548713, 6293.056041593706, 6298.023806309938, 6301.0, 5918.378570250062, 5974.103884417372, 5998.1002849572915, 6024.668643224665, 6089.665068421102, 6253.8749225014335, 6270.435660790551, 6278.654673992792, 6283.277423096402, 6296.244450665949, 5816.47651711348, 5962.880742385215, 5967.403259673998, 5970.044792833126, 6008.819735407945, 5946.881062378815, 5997.520198384032, 6007.639541627516, 6024.246969128859, 6033.517318614413, 5858.912116318344, 5877.647341159544, 5887.735051922759, 5894.528437725057, 5902.940970590239, 5702.030654788613, 5766.192733017465, 5796.913046304393, 5850.444207800252, 5866.765329386777, 5719.027765279996, 5766.913496297475, 5770.740316685676, 5773.04744717117, 5800.622959507618, 5869.295684517885, 5880.117982302689, 5901.91147132802, 5908.291005079418, 5916.408359164049, 5522.917156242579, 5689.459501347365, 5709.400512946247, 5768.509676677361, 5785.768569257182], "value": 5547.272530735421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.3275397063228, 659.7031335898844, 668.044696084599, 669.7689297192467, 672.096030838522, 33231.50152747708, 46177.76911115444, 46693.29960050602, 46749.29876051862, 46818.0, 49788.0, 50185.24722129171, 50223.24665130026, 50240.748796256055, 50280.24579631309, 8419.115992820758, 9051.63793448263, 9209.447433154031, 9211.355205135644, 10730.19523535734, 10646.041856232938, 11082.390468524229, 11105.333679979187, 11114.277571957837, 11115.44422778862, 11141.0, 11192.832107518394, 11194.776104477945, 11197.160212984018, 11202.383868887207, 8486.575671216415, 10791.676249712442, 11003.724906877313, 11134.61028863994, 11168.0, 10621.681349559449, 10988.615398461096, 11031.282966607145, 11040.558377664884, 11051.17116216279, 47416.0, 48063.75968120137, 48075.0, 48083.75958120187, 48133.75933120347, 3862.4978752761963, 3895.454636350913, 4362.367456718758, 4469.888252793674, 4564.885877853047, 36613.633863661285, 36815.44776828323, 36882.0, 36906.44640330397, 36917.0, 4677.111348843743, 4680.64895132863, 4687.273472611751, 4758.143534163849, 4777.474477807438, 424059.0, 425133.0, 425512.0, 425961.0, 426830.9999999969, 35342.82328588341, 35949.46075808865, 72402.0, 73162.0, 73169.6341518289, 42234.36648450276, 42306.15387692229, 42406.78796606059, 42510.362344564855, 42537.78731106387, 17504.91247543754, 17689.911550442164, 17711.55721106957, 17713.7342939856, 17715.73426398605, 13562.321883905764, 14895.702085958437, 14975.850241497663, 15089.094654320776, 15430.38278468871, 9326.114019168168, 9416.387934784218, 9450.291228157916, 9460.24318054554, 9513.238940884712, 3546.5744110706883, 3551.857925682944, 3568.5360903082433, 3619.94570081449, 3642.4718415829557, 1047.3244757131608, 1101.6089288302696, 1111.349860331699, 1200.4117982188666, 1217.3061355027726, 34866.82566587151, 35353.0, 35496.64503354985, 35596.64403355985, 35837.0, 1208.8186771984097, 1217.6712287682276, 1219.3415555600054, 1234.5061975209987, 1241.5608763724613, 17705.645887082443, 18322.633547329246, 18340.0, 18426.81573184251, 18546.0, 639309.0, 649871.0, 650067.0, 650140.0, 650710.0, 67409.32590674129, 67996.0, 67996.6600166996, 68017.0, 68039.0, 1341.1014620204487, 1385.2450414524108, 1438.927998641019, 1475.6901050779243, 1479.9556013319618, 32308.83845580757, 35616.89009248526, 35723.64276357203, 35837.64162358447, 36107.09732256715, 54654.453455464936, 55999.0, 56057.0, 56082.439175607724, 56098.0, 467359.0, 471422.0, 474607.0, 475415.0, 476344.0, 27820.443591128467, 30135.397292054473, 30674.233144171576, 31628.841855790575, 32138.517922231655, 53693.463065368844, 53869.730651346494, 54420.0, 55071.449285506635, 55224.72387638036, 44455.77772111119, 44867.737505224504, 45812.770936145105, 45948.540514594424, 46112.53887461082, 43495.13009739724, 44755.552444475135, 44829.41364690752, 45341.54658453373, 46111.53888461207, 44046.559534404245, 44361.77819110884, 44756.32865506955, 45112.0, 45699.31451028171, 38286.61713382942, 39379.6062039376, 39787.40318895161, 40217.59782402139, 40336.00095319364, 29791.255218619706, 29910.70089299079, 29944.401111978073, 29983.70016299809, 30594.0], "value": 21230.967509259004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.1916008403151, 412.0666689947268, 413.6483988609682, 415.55950692266197, 430.7221841911967, 19146.808531914678, 19856.90071549644, 20566.794332056692, 20690.586188276244, 20938.790612093875, 12466.189697669644, 12745.490180392797, 18110.4566862994, 20913.47716307093, 20938.37184884452, 5209.114450543398, 5403.756830942597, 5684.516816070618, 5895.292564892219, 5903.527717782567, 5843.386444423338, 5861.062230043194, 5872.324682661484, 5872.9706351468185, 5892.705364731768, 5756.568257380693, 5815.127730840365, 5888.146218798293, 5892.086726557391, 5898.469137777599, 5777.653340799566, 5825.504832089277, 5828.009238429478, 5839.5620328475325, 6177.845553861144, 5626.549876009909, 5723.742431590588, 5749.137629355589, 5755.568332375046, 5759.625624334405, 13589.184648920998, 13773.793393099011, 23168.0, 24270.39324016896, 25589.872050639813, 2325.081592770846, 2664.200739778078, 2913.4610097131886, 2936.750376218024, 3047.130144716198, 10142.087212150942, 10629.574817007311, 12010.219335743235, 12265.938670306592, 15258.703010244142, 1907.0560072763933, 1940.9421865083564, 1985.9503512412161, 2045.3966080006285, 2072.367927782026, 84974.57512712458, 87292.0, 87543.56228218818, 87601.12398876058, 89989.55005224998, 11237.157213209042, 11247.493862776195, 11259.155563332783, 11328.886711132784, 11386.373749443861, 15386.153761543223, 15445.996010259298, 15512.146831924352, 15526.1460619667, 15589.376424942875, 7846.176151504124, 7972.720954766555, 8099.271065604006, 8115.634796434175, 8237.135100814448, 7629.504082234637, 7683.6926522939575, 7713.382929365637, 7750.418718596128, 7785.571793551409, 4697.318888761179, 4763.118823017753, 4860.441049279378, 4863.10032643962, 4872.171730805771, 1806.8193180681826, 1818.7180986947044, 1876.2026138890917, 1899.6865517189508, 1909.6155287416511, 956.7082039977735, 1013.3514550687565, 1022.4632068164274, 1043.5929987304958, 1071.9571217151226, 19610.901945490183, 20865.478363041046, 20883.37349879506, 20908.059137338856, 20968.89515552443, 1004.2066767253933, 1012.1902478017556, 1032.76762728387, 1102.525913857049, 1118.558169523034, 11173.217874748852, 11438.542458301576, 11456.4844581994, 11499.540018399337, 11519.88480115188, 543347.0, 543606.0, 551957.0, 569819.0, 571099.0, 104864.47567762266, 106827.0, 107376.0, 108280.0, 108470.0, 1103.1285284625055, 1105.171121658756, 1116.832475128721, 1118.4966764955802, 1123.1800785426685, 17836.643267134845, 18255.361062362754, 18276.268949241883, 18350.72473912919, 18355.632887342446, 40099.0, 41786.58213417827, 41916.23345168653, 42096.15807683768, 43967.78016110027, 64040.3595964053, 64154.67922660357, 65317.34682653303, 65623.34376656363, 66459.33540664532, 8723.956380218058, 8973.28213742886, 9150.908490915006, 9400.29497787655, 9483.0, 9838.9016109838, 9996.850047249443, 11063.944680276547, 14669.70660586761, 14760.852391475948, 12540.811887821872, 12831.679208019874, 12841.293728845003, 12977.675558111123, 13058.738825223252, 12424.0, 12822.807657884952, 12882.935585322013, 12888.291143986795, 12951.481940722642, 10082.092611664986, 12810.295433751233, 12932.676683082998, 12978.156419832681, 13100.213987160801, 7700.653470593725, 8937.553122343726, 9083.545822708971, 9275.118863707938, 9441.386309889835, 11232.943835280772, 12838.0, 12858.807117893426, 13000.479980800663, 13127.540536081191], "value": 9594.30427849819, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.2098293481238, 1551.5190291009785, 1568.5529624057144, 1676.7736355591999, 1769.5133838194495, 9050.90949090509, 9419.858702119465, 9428.245740340773, 9694.12752852245, 9698.612055517788, 9400.0, 9574.2340612751, 9583.233341332694, 9586.089321514462, 9593.136617704406, 2185.803277705006, 2445.498672772086, 2464.950700985975, 2493.0401795308753, 2522.2685421227916, 2513.5852584323566, 2530.8987640494356, 2532.556802559554, 2533.1767175667887, 2537.8731063446753, 2493.7381574934643, 2509.5482813093636, 2510.297116807297, 2512.560301947161, 2512.6482292478977, 2062.9690554641693, 2133.7332833395826, 2133.775953524889, 2309.1571576374504, 2428.040923835084, 2438.7195472520534, 2445.2419749877595, 2451.6935383077116, 2451.705795304557, 2457.1154384421593, 9108.635654573809, 9145.725628231165, 9156.8626470603, 9159.725208243763, 9171.266298696088, 5405.8107966221, 5519.337679478448, 5528.143137813645, 5537.612367134302, 5540.0, 3425.4519276915576, 3476.5132881396626, 3589.73077019222, 3593.7304702147444, 3643.508126402928, 1202.41081869884, 1203.2840459926417, 1211.5275042733342, 1222.9021678265717, 1224.0574757436814, 13269.0, 13319.53381631648, 13338.13302135358, 13341.266230357327, 13354.732905341936, 4850.369451971221, 4882.536159064884, 4987.850364489072, 4993.726599717049, 5012.523810238022, 11118.277311974858, 11147.108231341474, 11165.330080195214, 11173.05029072538, 11185.0, 5664.716764161775, 5673.744681489343, 5674.120511320752, 5674.26234589509, 5678.0, 4537.478190008125, 5044.873878153002, 5143.382794064736, 5147.099257629975, 5254.369475662868, 4363.061941682554, 4379.430674012422, 4398.406215160976, 4453.487848897354, 4463.24124898768, 1375.5116933488669, 1383.8131852200027, 1417.4054189037333, 1434.3688776938113, 1441.891858110625, 980.5097451274363, 1013.8175128476797, 1021.8569400283966, 1028.9176865850714, 1083.128081894083, 6541.934580654228, 6604.240512341143, 6604.537682362188, 6633.867322653617, 6814.1482314710665, 459.7333546542997, 463.83533845485044, 468.83825080347225, 468.9015306785545, 469.317143556125, 4687.554682305175, 4755.476897541268, 4837.685550439211, 4840.540148685869, 4885.5847252983895, 11769.646910592524, 12169.574064907685, 12185.207961482476, 12508.562200322946, 12520.31138287403, 12308.138430309793, 12328.137030407965, 12347.6913077172, 12362.567310144103, 12375.319357435428, 8765.780855478664, 8784.077671844492, 8935.329850261256, 8939.553022348857, 8970.596323165342, 6500.382463665944, 6625.304343044104, 6636.767713130017, 6831.521793474409, 6876.965615171892, 10592.788144236918, 10616.309939853885, 10952.835707464235, 10981.560737570408, 11007.174461915549, 10923.12614990783, 10979.780404392028, 10984.395858227874, 10991.780164396827, 11073.83389249178, 7795.649195786316, 8027.919720802717, 8166.7958301042945, 8711.91288087111, 8894.4663320201, 8992.955035225044, 9006.954965225132, 9017.684381046894, 9050.185483306534, 9075.0, 7862.253085956825, 8039.276465118168, 8088.110307866013, 8183.73152161416, 8227.588620569068, 7932.801679958047, 8096.109427963037, 8246.546439945621, 8369.414141010071, 8496.235338819535, 7513.4740568159705, 7528.51064680794, 7644.770656880302, 7660.5403675779635, 7675.731349402744, 5866.656026016349, 5926.2295901532525, 5980.551458640706, 6030.185924900258, 6049.3950604939155, 5637.520810731134, 5734.283214598176, 5891.1752354669525, 5972.134040564007, 6042.969785151046], "value": 4905.52561007633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5012107867368, 361.24319550541617, 365.9835307411166, 372.32237328062934, 373.70664028737446, 5379.488948549892, 5462.781488740446, 5545.279113715216, 5572.0, 5589.972050139749, 5452.91820622691, 5462.672239665623, 5478.397376288605, 5478.616496845222, 5514.172874068891, 4312.913741725163, 4336.544662810406, 4358.760268185249, 4362.498312694049, 4376.168527979674, 3988.361862102064, 4040.616141466556, 4314.245007123756, 4367.54140815213, 4372.8032238549185, 4245.596668316521, 4262.46719160105, 4272.722273052257, 4283.528811830696, 4302.462192225972, 4263.211305908417, 4264.336908605646, 4275.123599662062, 4283.97858010711, 4302.139572085564, 3740.4576336431337, 3806.7525610835482, 3849.4610754494115, 3852.8073596320073, 3863.903402414934, 5213.540208741559, 5239.633225674204, 5241.685498870042, 5283.445238249967, 5302.92045619316, 4833.516648335173, 4900.191468407708, 4911.4106307243, 4919.163742163841, 4920.0, 5563.693996830173, 5736.569757268222, 5754.165645981351, 5778.479936805707, 5788.652680839163, 4155.0, 4193.370994350841, 4196.4964204295375, 4196.643285320752, 4204.4653701399075, 5890.646561206341, 5971.820845374646, 5995.910061349084, 6011.098335249704, 6031.879362412771, 4271.402003719481, 4271.530131685512, 4279.358096285582, 4290.206311832321, 4292.862391466201, 4344.174606824693, 4344.218040752632, 4344.782760862007, 4355.564443555619, 4358.825646974085, 4916.640012793879, 4917.631177661689, 4938.358013458227, 4946.678465899777, 4967.105920934194, 5673.858153546194, 5800.680962547016, 5822.030764310232, 5834.474897259267, 5836.9124463133085, 1404.859514048587, 1441.4306348992088, 1486.1900264355952, 1513.3265696764834, 1514.871235944957, 949.4493193947494, 962.7063745557672, 970.4225985538593, 974.4543055888724, 974.8245315843075, 5010.173321401928, 5108.412532558729, 5116.360454943132, 5119.0017946500075, 5136.948630513647, 5246.501582349671, 5258.0, 5279.788808447619, 5344.225087362389, 5362.498500419889, 4733.739644319596, 4983.451820299764, 5005.224190250517, 5007.84976450707, 5059.696418214919, 2802.3694668699786, 2802.8598570071413, 2804.5652923796843, 2817.7464028237146, 2823.788215883817, 5303.310569625924, 5309.230161626542, 5355.812546560852, 5392.379876314196, 5432.6468779529205, 5061.469265367316, 5204.22476698778, 5323.946760532345, 5367.892642147135, 5384.488473595002, 5406.1887818335035, 5407.621466497386, 5446.863828404401, 5467.699276539828, 5475.206095116186, 5261.763220655003, 5348.946510535001, 5355.955588660329, 5370.140777475585, 5379.784808607768, 4952.47998960104, 5277.366715994105, 5291.068759902685, 5293.2854064702315, 5325.281087053353, 5392.730363481732, 5422.728863556886, 5449.209864569694, 5510.952918945388, 5524.762471199171, 3912.628300311466, 3942.566317704993, 3947.8223479944045, 3967.2065586882163, 3979.602039796113, 4981.925271120864, 5279.762410691605, 5285.867853303698, 5684.5556410743775, 5846.41535846412, 5680.318361796611, 5686.545076393796, 5704.543636509153, 5710.486056254791, 5809.228185403493, 5703.828885133453, 5714.79998200061, 5743.282089738783, 5749.958764638493, 5764.510016648464, 5595.720213989365, 5643.0249412705225, 5677.68772717488, 5680.602357834912, 5722.713864306851, 5729.71351432435, 5758.971205143947, 5760.917908918708, 5768.798092066925, 5800.187973683604, 5470.56235501151, 5689.829305120853, 5721.771129154788, 5724.3703192647945, 5740.0], "value": 4259.406278005546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.8356470488258, 869.6651789061211, 883.3816328570002, 884.694780300796, 895.7312806158153, 15225.086494810304, 16259.756103658454, 16317.510474685749, 16320.510384688478, 16358.918205408956, 15467.381304747796, 15701.214939253021, 15705.371785128582, 15716.135612541306, 15720.213989300517, 735.2133217457323, 852.4544291653347, 862.8964524257067, 874.4403581707712, 885.7387070814093, 878.9428687135347, 883.2845395229853, 885.3713863157134, 886.7960369115075, 889.4440974391006, 930.4463844012802, 939.0797018921461, 939.2673714502699, 939.3049143633696, 939.6476321379482, 777.8872063550782, 913.5112714697638, 927.0, 929.9442033478012, 932.2868005975434, 683.7470136049644, 685.1606781692436, 685.3112621815044, 685.9108315918949, 686.2691233835999, 15809.92095039529, 15869.285882135217, 15930.920345398315, 15936.920315398465, 15943.601409964727, 15503.689926201412, 15574.454894078766, 15608.687826243526, 15652.921735391365, 15739.92130039354, 13495.325233738275, 13583.0, 13624.318784060757, 13639.386227619781, 13677.589672309847, 4682.29765535169, 4715.481297057355, 4718.528147185289, 4793.688410253322, 4814.10938976287, 79115.81326280053, 79222.20777792264, 80318.59840700818, 80700.59649701773, 80705.59647201785, 12300.630981070582, 12341.13612047166, 12522.749545009048, 12573.119881608383, 12680.23918564889, 22318.888405557867, 22329.106835726714, 22348.888255558617, 22364.776352236593, 22379.216727414463, 9135.360524763202, 9263.76840578991, 9596.136347728738, 9707.9029209707, 9718.854217186748, 4993.725345105981, 5006.3992320921725, 5197.272381866542, 5228.37259528859, 5244.108501554745, 3550.485179648988, 3663.7435379523176, 3668.0, 3672.2288319453214, 3673.7612055216327, 632.2539403503818, 659.1069101367674, 697.2852825853439, 700.9088818453569, 713.2368365848492, 721.8736721073897, 839.8152406470567, 845.8646616541324, 854.1927878155084, 860.2902605350611, 11512.481938312796, 11552.364619945816, 11684.771756060572, 11803.17377783564, 11846.0, 669.4911866981032, 789.7235967411475, 790.9841803163904, 809.6842231529708, 832.342449464916, 5270.552003079704, 5412.827605420765, 5443.319585051869, 5497.47773961473, 5521.69630670317, 109538.0, 124246.0, 126172.36913815372, 130403.0, 133743.0, 108490.0, 112417.25496470074, 112436.49502440394, 113057.0, 113211.0, 98471.0, 102270.0, 103610.48194758978, 104230.0, 107000.92999070065, 9832.803343933225, 10225.642102526375, 10235.846462302923, 10371.325863818827, 10411.427371494641, 57817.710911445174, 58334.4166558346, 58632.0, 58723.41276587179, 59510.40489595049, 81120.0, 82791.58604206941, 83153.58423207846, 84686.0, 84985.15014849772, 12885.742285154058, 12972.545960891324, 13207.471701131846, 13331.866681333062, 13556.86443135556, 12042.337671428155, 14373.496927607484, 15329.923350383177, 15716.292766825749, 16069.598260043593, 13130.343482826012, 14294.285285735463, 15128.773068403763, 16524.504264872074, 16525.0, 13104.344782760632, 13916.956228282717, 15111.697766044837, 15458.613534661723, 15773.842261577238, 13405.262710551013, 13818.309084545934, 13929.651758706113, 14004.089734167246, 14054.648633784238, 12498.500059997497, 12554.246745195318, 12678.87321126777, 12962.092653514164, 13013.284269365276, 12677.429515671633, 12789.872101279241, 12813.93593032029, 13020.9583233343, 13139.54011609589], "value": 8292.301622166151, "unit": "score"}], "name": "dromaeo_css", "value": 7620.256072290342, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 125.0, 182.0, 126.0, 132.0, 146.0, 123.0, 165.0, 124.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 159.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 125.0, 74.0, 76.0, 75.0, 74.0, 100.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 84.0, 85.0, 84.0, 114.0, 85.0, 85.0, 135.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 52.0, 52.0, 53.0, 53.0, 51.0, 53.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 76.0, 76.0, 76.0, 77.0, 76.0, 76.0, 108.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 131.0, 114.0, 114.0, 115.0, 124.0, 125.0, 127.0, 133.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 155.0, 159.0, 150.0, 151.0, 154.0, 152.0, 151.0, 150.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 66.0, 61.0, 65.0, 60.0, 61.0, 63.0, 62.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1475.8, "alertThreshold": 2.0}]} 08:44:04 INFO - Return code: 0 08:44:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:04 ERROR - # TBPL SUCCESS # 08:44:04 INFO - Running post-action listener: _resource_record_post_action 08:44:04 INFO - ##### 08:44:04 INFO - ##### Finished run-tests step (success) 08:44:04 INFO - ##### 08:44:04 INFO - Running post-run listener: _resource_record_post_run 08:44:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510791680; Read time: 12; Write time: 575628 08:44:04 INFO - TinderboxPrint: CPU usage
13.2% 08:44:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:44:04 INFO - TinderboxPrint: I/O write bytes / time
510,791,680 / 575,628 08:44:04 INFO - TinderboxPrint: CPU idle
8,252.2 (86.8%) 08:44:04 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 08:44:04 INFO - TinderboxPrint: Swap in / out
0 / 0 08:44:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 260014080; Read time: 0; Write time: 310664 08:44:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250777600; Read time: 12; Write time: 264964 08:44:04 INFO - Running post-run listener: _upload_blobber_files 08:44:04 INFO - Blob upload gear active. 08:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:04 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 08:44:04 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'] 08:44:04 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 08:44:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:05 INFO - (blobuploader) - INFO - Done attempting. 08:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:09 INFO - (blobuploader) - INFO - Done attempting. 08:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:10 INFO - (blobuploader) - INFO - Done attempting. 08:44:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:10 INFO - Return code: 0 08:44:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d94163fc868fafbf05b04a2f756db8a421f5554de7d375ed376b73b6200dec6a4b6d748e0f7066927c49e15109aa10d1cbd6697fc59c5766f8fb2be0f176e975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf5441f017aaef554cf25ef80bb54483fde779cacf16683cdede08a99d60e8918caa97be3372061620012a0635bb7d56f580496887b0af419ec71bee8ed2f65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a32608968f396e29f1b48354a94ab9f249e8cc8c84586d02b4eda011096af6734c13546521cab28d1b136d95dc584eaf90987cfb5c5815cfd8c88ae20b0cc527"} 08:44:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:10 INFO - Contents: 08:44:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d94163fc868fafbf05b04a2f756db8a421f5554de7d375ed376b73b6200dec6a4b6d748e0f7066927c49e15109aa10d1cbd6697fc59c5766f8fb2be0f176e975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf5441f017aaef554cf25ef80bb54483fde779cacf16683cdede08a99d60e8918caa97be3372061620012a0635bb7d56f580496887b0af419ec71bee8ed2f65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a32608968f396e29f1b48354a94ab9f249e8cc8c84586d02b4eda011096af6734c13546521cab28d1b136d95dc584eaf90987cfb5c5815cfd8c88ae20b0cc527"} 08:44:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:10 INFO - Copying logs to upload dir... 08:44:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.660831 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-27 08:44:10.458775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:44:10.462565) ========= 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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 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/d94163fc868fafbf05b04a2f756db8a421f5554de7d375ed376b73b6200dec6a4b6d748e0f7066927c49e15109aa10d1cbd6697fc59c5766f8fb2be0f176e975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf5441f017aaef554cf25ef80bb54483fde779cacf16683cdede08a99d60e8918caa97be3372061620012a0635bb7d56f580496887b0af419ec71bee8ed2f65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a32608968f396e29f1b48354a94ab9f249e8cc8c84586d02b4eda011096af6734c13546521cab28d1b136d95dc584eaf90987cfb5c5815cfd8c88ae20b0cc527"} build_url:https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/bqFWrtZDQLS_Rh2PJbFNTw/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/d94163fc868fafbf05b04a2f756db8a421f5554de7d375ed376b73b6200dec6a4b6d748e0f7066927c49e15109aa10d1cbd6697fc59c5766f8fb2be0f176e975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf5441f017aaef554cf25ef80bb54483fde779cacf16683cdede08a99d60e8918caa97be3372061620012a0635bb7d56f580496887b0af419ec71bee8ed2f65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a32608968f396e29f1b48354a94ab9f249e8cc8c84586d02b4eda011096af6734c13546521cab28d1b136d95dc584eaf90987cfb5c5815cfd8c88ae20b0cc527"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:44:10.488124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:44:10.488467) ========= 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=920470bf432669ad7e3a5387000001ca-1467041016.851389-1589967935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:44:10.571416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:44:10.571831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:44:10.572237) ========= ========= Total master_lag: 0.17 =========