builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1467973956.93 results: success (0) buildid: 20160708004052 builduid: d3a4d8a905324d4583946257d3fa4057 revision: 00e9101b9ed0353afd4e7dd956a063d7ac511c91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:36.931448) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:36.931928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:36.932224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:36.947157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:36.947425) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 03:32:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.7M=0.001s 2016-07-08 03:32:38 (22.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.115388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.115717) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019329 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.165358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.165860) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 00e9101b9ed0353afd4e7dd956a063d7ac511c91 --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 00e9101b9ed0353afd4e7dd956a063d7ac511c91 --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=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 03:32:38,517 truncating revision to first 12 chars 2016-07-08 03:32:38,517 Setting DEBUG logging. 2016-07-08 03:32:38,517 attempt 1/10 2016-07-08 03:32:38,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/00e9101b9ed0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 03:32:38,815 unpacking tar archive at: mozilla-aurora-00e9101b9ed0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.778152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.778471) ========= script_repo_revision: 00e9101b9ed0353afd4e7dd956a063d7ac511c91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.778879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.779223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:32:37.789364) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-08 03:32:37.789647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:39 INFO - MultiFileLogger online at 20160708 03:32:39 in /builds/slave/test 03:32:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:39 INFO - {'append_to_log': False, 03:32:39 INFO - 'base_work_dir': '/builds/slave/test', 03:32:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:39 INFO - 'branch': 'Mozilla-Aurora', 03:32:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:39 INFO - 'config_files': ('talos/linux_config.py',), 03:32:39 INFO - 'default_actions': ('clobber', 03:32:39 INFO - 'read-buildbot-config', 03:32:39 INFO - 'download-and-extract', 03:32:39 INFO - 'populate-webroot', 03:32:39 INFO - 'create-virtualenv', 03:32:39 INFO - 'install', 03:32:39 INFO - 'run-tests'), 03:32:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:39 INFO - 'download_minidump_stackwalk': True, 03:32:39 INFO - 'download_symbols': 'ondemand', 03:32:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:39 INFO - 'installer_path': 'installer.exe', 03:32:39 INFO - 'log_level': 'info', 03:32:39 INFO - 'log_name': 'talos', 03:32:39 INFO - 'log_to_console': True, 03:32:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:39 INFO - 'opt_config_files': (), 03:32:39 INFO - 'pip_index': False, 03:32:39 INFO - 'sps_profile': False, 03:32:39 INFO - 'sps_profile_interval': 0, 03:32:39 INFO - 'suite': 'dromaeojs-e10s', 03:32:39 INFO - 'system_bits': '32', 03:32:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:39 INFO - 'title': 'talos-linux64-ix-067', 03:32:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:39 INFO - 'use_talos_json': True, 03:32:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:39 INFO - 'work_dir': 'build'} 03:32:39 INFO - ##### 03:32:39 INFO - ##### Running clobber step. 03:32:39 INFO - ##### 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: clobber 03:32:39 INFO - rmtree: /builds/slave/test/build 03:32:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - ##### 03:32:39 INFO - ##### Finished clobber step (success) 03:32:39 INFO - ##### 03:32:39 INFO - ##### 03:32:39 INFO - ##### Running read-buildbot-config step. 03:32:39 INFO - ##### 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: read_buildbot_config 03:32:39 INFO - Using buildbot properties: 03:32:39 INFO - { 03:32:39 INFO - "project": "", 03:32:39 INFO - "product": "firefox", 03:32:39 INFO - "script_repo_revision": "production", 03:32:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:39 INFO - "repository": "", 03:32:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:39 INFO - "buildid": "20160708004052", 03:32:39 INFO - "stage_platform": "linux64-pgo", 03:32:39 INFO - "basedir": "/builds/slave/test", 03:32:39 INFO - "nightly_build": "True", 03:32:39 INFO - "buildnumber": 436, 03:32:39 INFO - "slavename": "talos-linux64-ix-067", 03:32:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:32:39 INFO - "platform": "ubuntu64_hw", 03:32:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:39 INFO - "branch": "mozilla-aurora", 03:32:39 INFO - "repo_path": "releases/mozilla-aurora", 03:32:39 INFO - "revision": "00e9101b9ed0353afd4e7dd956a063d7ac511c91", 03:32:39 INFO - "pgo_build": "True", 03:32:39 INFO - "builduid": "d3a4d8a905324d4583946257d3fa4057", 03:32:39 INFO - "slavebuilddir": "test" 03:32:39 INFO - } 03:32:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - ##### 03:32:39 INFO - ##### Finished read-buildbot-config step (success) 03:32:39 INFO - ##### 03:32:39 INFO - ##### 03:32:39 INFO - ##### Running download-and-extract step. 03:32:39 INFO - ##### 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: download_and_extract 03:32:39 INFO - mkdir: /builds/slave/test/build/tests 03:32: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')]} 03:32:39 INFO - https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:40 INFO - Downloaded 1361 bytes. 03:32:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:40 INFO - Using the following test package requirements: 03:32:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'jsshell-linux-x86_64.zip'], 03:32:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32: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')]} 03:32:40 INFO - https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:41 INFO - Downloaded 24525620 bytes. 03:32: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'] 03:32: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 03:32:42 INFO - Return code: 0 03:32: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 03:32: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')]} 03:32:42 INFO - https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:44 INFO - Downloaded 24525620 bytes. 03:32:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:46 INFO - Return code: 0 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:47 INFO - Downloaded 10833369 bytes. 03:32:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:47 INFO - Return code: 0 03:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:47 INFO - https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:48 INFO - Downloaded 63637316 bytes. 03:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:48 INFO - mkdir: /builds/slave/test/properties 03:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:48 INFO - Contents: 03:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:49 INFO - Running post-action listener: _resource_record_post_action 03:32:49 INFO - Running post-action listener: set_extra_try_arguments 03:32:49 INFO - ##### 03:32:49 INFO - ##### Finished download-and-extract step (success) 03:32:49 INFO - ##### 03:32:49 INFO - ##### 03:32:49 INFO - ##### Running populate-webroot step. 03:32:49 INFO - ##### 03:32:49 INFO - Running pre-action listener: _resource_record_pre_action 03:32:49 INFO - Running main action method: populate_webroot 03:32:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:49 INFO - '--tppagecycles', 03:32:49 INFO - '7'], 03:32:49 INFO - 'tests': ['tsvgm']}}, 03:32:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['damp', 'tps']}, 03:32:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'tests': ['damp', 'tps']}, 03:32:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['dromaeo_dom']}, 03:32:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['a11yr', 03:32:49 INFO - 'ts_paint', 03:32:49 INFO - 'tpaint', 03:32:49 INFO - 'sessionrestore', 03:32:49 INFO - 'sessionrestore_no_auto_restore', 03:32:49 INFO - 'tabpaint']}, 03:32:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['tsvgx', 03:32:49 INFO - 'tsvgr_opacity', 03:32:49 INFO - 'tart', 03:32:49 INFO - 'tscrollx', 03:32:49 INFO - 'cart']}, 03:32:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:49 INFO - 'tsvgr_opacity', 03:32:49 INFO - 'tart', 03:32:49 INFO - 'tscrollx', 03:32:49 INFO - 'cart']}, 03:32:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'talos_options': ['--disable-e10s'], 03:32:49 INFO - 'tests': ['tp5o']}, 03:32:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'tests': ['tp5o']}, 03:32:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'talos_options': ['--disable-e10s', 03:32:49 INFO - '--xperf_path', 03:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:49 INFO - 'tests': ['tp5n']}, 03:32:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:49 INFO - 'talos_options': ['--xperf_path', 03:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:49 INFO - 'tests': ['tp5n']}}, 03:32:49 INFO - 'talos.zip': {'path': '', 03:32:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:49 INFO - Running post-action listener: _resource_record_post_action 03:32:49 INFO - ##### 03:32:49 INFO - ##### Finished populate-webroot step (success) 03:32:49 INFO - ##### 03:32:49 INFO - ##### 03:32:49 INFO - ##### Running create-virtualenv step. 03:32:49 INFO - ##### 03:32:49 INFO - Running pre-action listener: _resource_record_pre_action 03:32:49 INFO - Running main action method: create_virtualenv 03:32:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:32:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:49 INFO - Using real prefix '/usr' 03:32:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:51 INFO - Installing pip.................done. 03:32:52 INFO - Return code: 0 03:32:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:52 INFO - Using env: {'DISPLAY': ':0', 03:32:52 INFO - 'HOME': '/home/cltbld', 03:32:52 INFO - 'LANG': 'en_US.UTF-8', 03:32:52 INFO - 'LANGUAGE': 'en_US:en', 03:32:52 INFO - 'LOGNAME': 'cltbld', 03:32:52 INFO - 'MAIL': '/var/mail/cltbld', 03:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:52 INFO - 'MOZ_NO_REMOTE': '1', 03:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:52 INFO - 'NO_EM_RESTART': '1', 03:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:52 INFO - 'PWD': '/builds/slave/test', 03:32:52 INFO - 'SHELL': '/bin/bash', 03:32:52 INFO - 'SHLVL': '1', 03:32:52 INFO - 'TERM': 'linux', 03:32:52 INFO - 'TMOUT': '86400', 03:32:52 INFO - 'USER': 'cltbld', 03:32:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:52 INFO - '_': '/tools/buildbot/bin/python'} 03:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:32:52 INFO - Cleaning up... 03:32:52 INFO - Return code: 0 03:32:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:32:52 INFO - Using env: {'DISPLAY': ':0', 03:32:52 INFO - 'HOME': '/home/cltbld', 03:32:52 INFO - 'LANG': 'en_US.UTF-8', 03:32:52 INFO - 'LANGUAGE': 'en_US:en', 03:32:52 INFO - 'LOGNAME': 'cltbld', 03:32:52 INFO - 'MAIL': '/var/mail/cltbld', 03:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:52 INFO - 'MOZ_NO_REMOTE': '1', 03:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:52 INFO - 'NO_EM_RESTART': '1', 03:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:52 INFO - 'PWD': '/builds/slave/test', 03:32:52 INFO - 'SHELL': '/bin/bash', 03:32:52 INFO - 'SHLVL': '1', 03:32:52 INFO - 'TERM': 'linux', 03:32:52 INFO - 'TMOUT': '86400', 03:32:52 INFO - 'USER': 'cltbld', 03:32:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:52 INFO - '_': '/tools/buildbot/bin/python'} 03:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:52 INFO - Downloading/unpacking psutil>=3.1.1 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:54 INFO - Installing collected packages: psutil 03:32:54 INFO - Running setup.py install for psutil 03:32:54 INFO - building 'psutil._psutil_linux' extension 03:32:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:32:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:32:54 INFO - building 'psutil._psutil_posix' extension 03:32:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:32: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 03:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:54 INFO - Successfully installed psutil 03:32:54 INFO - Cleaning up... 03:32:54 INFO - Return code: 0 03:32:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32: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 03:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:32:55 INFO - Using env: {'DISPLAY': ':0', 03:32:55 INFO - 'HOME': '/home/cltbld', 03:32:55 INFO - 'LANG': 'en_US.UTF-8', 03:32:55 INFO - 'LANGUAGE': 'en_US:en', 03:32:55 INFO - 'LOGNAME': 'cltbld', 03:32:55 INFO - 'MAIL': '/var/mail/cltbld', 03:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:55 INFO - 'MOZ_NO_REMOTE': '1', 03:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:55 INFO - 'NO_EM_RESTART': '1', 03:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:55 INFO - 'PWD': '/builds/slave/test', 03:32:55 INFO - 'SHELL': '/bin/bash', 03:32:55 INFO - 'SHLVL': '1', 03:32:55 INFO - 'TERM': 'linux', 03:32:55 INFO - 'TMOUT': '86400', 03:32:55 INFO - 'USER': 'cltbld', 03:32:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:55 INFO - '_': '/tools/buildbot/bin/python'} 03:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:57 INFO - Installing collected packages: mozsystemmonitor 03:32:57 INFO - Running setup.py install for mozsystemmonitor 03:32:57 INFO - Successfully installed mozsystemmonitor 03:32:57 INFO - Cleaning up... 03:32:57 INFO - Return code: 0 03:32:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:57 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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:32:57 INFO - Using env: {'DISPLAY': ':0', 03:32:57 INFO - 'HOME': '/home/cltbld', 03:32:57 INFO - 'LANG': 'en_US.UTF-8', 03:32:57 INFO - 'LANGUAGE': 'en_US:en', 03:32:57 INFO - 'LOGNAME': 'cltbld', 03:32:57 INFO - 'MAIL': '/var/mail/cltbld', 03:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:57 INFO - 'MOZ_NO_REMOTE': '1', 03:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:57 INFO - 'NO_EM_RESTART': '1', 03:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:57 INFO - 'PWD': '/builds/slave/test', 03:32:57 INFO - 'SHELL': '/bin/bash', 03:32:57 INFO - 'SHLVL': '1', 03:32:57 INFO - 'TERM': 'linux', 03:32:57 INFO - 'TMOUT': '86400', 03:32:57 INFO - 'USER': 'cltbld', 03:32:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:57 INFO - '_': '/tools/buildbot/bin/python'} 03:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:59 INFO - warning: no files found matching '*.txt' 03:32:59 INFO - no previously-included directories found matching 'build' 03:32:59 INFO - no previously-included directories found matching 'dist' 03:32:59 INFO - no previously-included directories found matching '.git*' 03:32:59 INFO - Installing collected packages: jsonschema, functools32 03:32:59 INFO - Running setup.py install for functools32 03:32:59 INFO - warning: no files found matching '*.txt' 03:32:59 INFO - no previously-included directories found matching 'build' 03:32:59 INFO - no previously-included directories found matching 'dist' 03:32:59 INFO - no previously-included directories found matching '.git*' 03:32:59 INFO - Successfully installed jsonschema functools32 03:32:59 INFO - Cleaning up... 03:32:59 INFO - Return code: 0 03:32:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32: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 03:32: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 03:32:59 INFO - Using env: {'DISPLAY': ':0', 03:32:59 INFO - 'HOME': '/home/cltbld', 03:32:59 INFO - 'LANG': 'en_US.UTF-8', 03:32:59 INFO - 'LANGUAGE': 'en_US:en', 03:32:59 INFO - 'LOGNAME': 'cltbld', 03:32:59 INFO - 'MAIL': '/var/mail/cltbld', 03:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:59 INFO - 'MOZ_NO_REMOTE': '1', 03:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:59 INFO - 'NO_EM_RESTART': '1', 03:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:59 INFO - 'PWD': '/builds/slave/test', 03:32:59 INFO - 'SHELL': '/bin/bash', 03:32:59 INFO - 'SHLVL': '1', 03:32:59 INFO - 'TERM': 'linux', 03:32:59 INFO - 'TMOUT': '86400', 03:32:59 INFO - 'USER': 'cltbld', 03:32:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:59 INFO - '_': '/tools/buildbot/bin/python'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - Downloading docopt-0.6.1.tar.gz 03:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:02 INFO - Running setup.py install for blobuploader 03:33:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:02 INFO - Running setup.py install for requests 03:33:03 INFO - Running setup.py install for docopt 03:33:03 INFO - Successfully installed blobuploader requests docopt 03:33:03 INFO - Cleaning up... 03:33:03 INFO - Return code: 0 03:33:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:03 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 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:03 INFO - Using env: {'DISPLAY': ':0', 03:33:03 INFO - 'HOME': '/home/cltbld', 03:33:03 INFO - 'LANG': 'en_US.UTF-8', 03:33:03 INFO - 'LANGUAGE': 'en_US:en', 03:33:03 INFO - 'LOGNAME': 'cltbld', 03:33:03 INFO - 'MAIL': '/var/mail/cltbld', 03:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:03 INFO - 'MOZ_NO_REMOTE': '1', 03:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:03 INFO - 'NO_EM_RESTART': '1', 03:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:03 INFO - 'PWD': '/builds/slave/test', 03:33:03 INFO - 'SHELL': '/bin/bash', 03:33:03 INFO - 'SHLVL': '1', 03:33:03 INFO - 'TERM': 'linux', 03:33:03 INFO - 'TMOUT': '86400', 03:33:03 INFO - 'USER': 'cltbld', 03:33:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:03 INFO - '_': '/tools/buildbot/bin/python'} 03:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:03 INFO - Running setup.py (path:/tmp/pip-vuh2SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:03 INFO - Running setup.py (path:/tmp/pip-e_U0Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:03 INFO - Running setup.py (path:/tmp/pip-KPOPh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:03 INFO - Running setup.py (path:/tmp/pip-slWEYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:03 INFO - Running setup.py (path:/tmp/pip-SQSjUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:03 INFO - Running setup.py (path:/tmp/pip-_gUfIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:04 INFO - Running setup.py (path:/tmp/pip-23RCXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:04 INFO - Running setup.py (path:/tmp/pip-_5ijHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:04 INFO - Running setup.py (path:/tmp/pip-_YCIKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:04 INFO - Running setup.py (path:/tmp/pip-cNRwes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:04 INFO - Running setup.py (path:/tmp/pip-G9G9n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:04 INFO - Running setup.py (path:/tmp/pip-4SfzEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:04 INFO - Running setup.py (path:/tmp/pip-XMs0XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:04 INFO - Running setup.py (path:/tmp/pip-r7tDdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:04 INFO - Running setup.py (path:/tmp/pip-0jmGW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:04 INFO - Running setup.py (path:/tmp/pip-wH7v8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:04 INFO - Running setup.py (path:/tmp/pip-fOpI0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:04 INFO - Running setup.py install for manifestparser 03:33:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:04 INFO - Running setup.py install for mozcrash 03:33:05 INFO - Running setup.py install for mozdebug 03:33:05 INFO - Running setup.py install for mozdevice 03:33:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozfile 03:33:05 INFO - Running setup.py install for mozhttpd 03:33:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozinfo 03:33:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozInstall 03:33:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozleak 03:33:05 INFO - Running setup.py install for mozlog 03:33:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for moznetwork 03:33:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozprocess 03:33:06 INFO - Running setup.py install for mozprofile 03:33:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozrunner 03:33:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozscreenshot 03:33:06 INFO - Running setup.py install for moztest 03:33:06 INFO - Running setup.py install for mozversion 03:33:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:06 INFO - Cleaning up... 03:33:06 INFO - Return code: 0 03:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:06 INFO - Using env: {'DISPLAY': ':0', 03:33:06 INFO - 'HOME': '/home/cltbld', 03:33:06 INFO - 'LANG': 'en_US.UTF-8', 03:33:06 INFO - 'LANGUAGE': 'en_US:en', 03:33:06 INFO - 'LOGNAME': 'cltbld', 03:33:06 INFO - 'MAIL': '/var/mail/cltbld', 03:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:06 INFO - 'MOZ_NO_REMOTE': '1', 03:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:06 INFO - 'NO_EM_RESTART': '1', 03:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:06 INFO - 'PWD': '/builds/slave/test', 03:33:06 INFO - 'SHELL': '/bin/bash', 03:33:06 INFO - 'SHLVL': '1', 03:33:06 INFO - 'TERM': 'linux', 03:33:06 INFO - 'TMOUT': '86400', 03:33:06 INFO - 'USER': 'cltbld', 03:33:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:06 INFO - '_': '/tools/buildbot/bin/python'} 03:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:06 INFO - Running setup.py (path:/tmp/pip-vnEKmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33: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)) 03:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:06 INFO - Running setup.py (path:/tmp/pip-JCX4Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:07 INFO - Running setup.py (path:/tmp/pip-l8hJz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:07 INFO - Running setup.py (path:/tmp/pip-_tIdHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:07 INFO - Running setup.py (path:/tmp/pip-BFQLJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:07 INFO - Running setup.py (path:/tmp/pip-sITcE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:07 INFO - Running setup.py (path:/tmp/pip-7dU1Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:07 INFO - Running setup.py (path:/tmp/pip-hzmac1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:07 INFO - Running setup.py (path:/tmp/pip-iD2VTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:07 INFO - Running setup.py (path:/tmp/pip-_Shu0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:07 INFO - Running setup.py (path:/tmp/pip-I2Alme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:07 INFO - Running setup.py (path:/tmp/pip-uJrdKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:07 INFO - Running setup.py (path:/tmp/pip-8RhkmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:07 INFO - Running setup.py (path:/tmp/pip-7XKTpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:07 INFO - Running setup.py (path:/tmp/pip-oxzVnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33: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)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:07 INFO - Running setup.py (path:/tmp/pip-7OzScD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:08 INFO - Running setup.py (path:/tmp/pip-cMxfu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:09 INFO - Downloading blessings-1.6.tar.gz 03:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:10 INFO - Installing collected packages: blessings 03:33:10 INFO - Running setup.py install for blessings 03:33:10 INFO - Successfully installed blessings 03:33:10 INFO - Cleaning up... 03:33:10 INFO - Return code: 0 03:33:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:10 INFO - Reading from file tmpfile_stdout 03:33:10 INFO - Current package versions: 03:33:10 INFO - argparse == 1.2.1 03:33:10 INFO - blessings == 1.6 03:33:10 INFO - blobuploader == 1.2.4 03:33:10 INFO - docopt == 0.6.1 03:33:10 INFO - functools32 == 3.2.3-2 03:33:10 INFO - jsonschema == 2.5.1 03:33:10 INFO - manifestparser == 1.1 03:33:10 INFO - mozInstall == 1.12 03:33:10 INFO - mozcrash == 0.17 03:33:10 INFO - mozdebug == 0.1 03:33:10 INFO - mozdevice == 0.48 03:33:10 INFO - mozfile == 1.2 03:33:10 INFO - mozhttpd == 0.7 03:33:10 INFO - mozinfo == 0.9 03:33:10 INFO - mozleak == 0.1 03:33:10 INFO - mozlog == 3.2 03:33:10 INFO - moznetwork == 0.27 03:33:10 INFO - mozprocess == 0.22 03:33:10 INFO - mozprofile == 0.28 03:33:10 INFO - mozrunner == 6.11 03:33:10 INFO - mozscreenshot == 0.1 03:33:10 INFO - mozsystemmonitor == 0.3 03:33:10 INFO - moztest == 0.7 03:33:10 INFO - mozversion == 1.4 03:33:10 INFO - psutil == 3.1.1 03:33:10 INFO - requests == 1.2.3 03:33:10 INFO - wsgiref == 0.1.2 03:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:10 INFO - Using env: {'DISPLAY': ':0', 03:33:10 INFO - 'HOME': '/home/cltbld', 03:33:10 INFO - 'LANG': 'en_US.UTF-8', 03:33:10 INFO - 'LANGUAGE': 'en_US:en', 03:33:10 INFO - 'LOGNAME': 'cltbld', 03:33:10 INFO - 'MAIL': '/var/mail/cltbld', 03:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:10 INFO - 'MOZ_NO_REMOTE': '1', 03:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:10 INFO - 'NO_EM_RESTART': '1', 03:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:10 INFO - 'PWD': '/builds/slave/test', 03:33:10 INFO - 'SHELL': '/bin/bash', 03:33:10 INFO - 'SHLVL': '1', 03:33:10 INFO - 'TERM': 'linux', 03:33:10 INFO - 'TMOUT': '86400', 03:33:10 INFO - 'USER': 'cltbld', 03:33:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:10 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:33:10 INFO - Cleaning up... 03:33:10 INFO - Return code: 0 03:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:10 INFO - Using env: {'DISPLAY': ':0', 03:33:10 INFO - 'HOME': '/home/cltbld', 03:33:10 INFO - 'LANG': 'en_US.UTF-8', 03:33:10 INFO - 'LANGUAGE': 'en_US:en', 03:33:10 INFO - 'LOGNAME': 'cltbld', 03:33:10 INFO - 'MAIL': '/var/mail/cltbld', 03:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:10 INFO - 'MOZ_NO_REMOTE': '1', 03:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:10 INFO - 'NO_EM_RESTART': '1', 03:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:10 INFO - 'PWD': '/builds/slave/test', 03:33:10 INFO - 'SHELL': '/bin/bash', 03:33:10 INFO - 'SHLVL': '1', 03:33:10 INFO - 'TERM': 'linux', 03:33:10 INFO - 'TMOUT': '86400', 03:33:10 INFO - 'USER': 'cltbld', 03:33:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:10 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:10 INFO - Cleaning up... 03:33:10 INFO - Return code: 0 03:33:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5537098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b04350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:33:10 INFO - Using env: {'DISPLAY': ':0', 03:33:10 INFO - 'HOME': '/home/cltbld', 03:33:10 INFO - 'LANG': 'en_US.UTF-8', 03:33:10 INFO - 'LANGUAGE': 'en_US:en', 03:33:10 INFO - 'LOGNAME': 'cltbld', 03:33:10 INFO - 'MAIL': '/var/mail/cltbld', 03:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:10 INFO - 'MOZ_NO_REMOTE': '1', 03:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:10 INFO - 'NO_EM_RESTART': '1', 03:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:10 INFO - 'PWD': '/builds/slave/test', 03:33:10 INFO - 'SHELL': '/bin/bash', 03:33:10 INFO - 'SHLVL': '1', 03:33:10 INFO - 'TERM': 'linux', 03:33:10 INFO - 'TMOUT': '86400', 03:33:10 INFO - 'USER': 'cltbld', 03:33:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:10 INFO - '_': '/tools/buildbot/bin/python'} 03:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:11 INFO - Downloading/unpacking flake8 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:13 INFO - no previously-included directories found matching 'docs/_build' 03:33:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:13 INFO - Running setup.py install for pep8 03:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:13 INFO - no previously-included directories found matching 'docs/_build' 03:33:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:13 INFO - Cleaning up... 03:33:13 INFO - Return code: 0 03:33:13 INFO - Running post-action listener: _resource_record_post_action 03:33:13 INFO - Running post-action listener: _start_resource_monitoring 03:33:14 INFO - Starting resource monitoring. 03:33:14 INFO - ##### 03:33:14 INFO - ##### Finished create-virtualenv step (success) 03:33:14 INFO - ##### 03:33:14 INFO - ##### 03:33:14 INFO - ##### Running install step. 03:33:14 INFO - ##### 03:33:14 INFO - Running pre-action listener: _resource_record_pre_action 03:33:14 INFO - Running main action method: install 03:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:14 INFO - Reading from file tmpfile_stdout 03:33:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:14 INFO - Reading from file tmpfile_stdout 03:33:14 INFO - Output received: 03:33:14 INFO - Usage: mozinstall [options] installer 03:33:14 INFO - Options: 03:33:14 INFO - -h, --help show this help message and exit 03:33:14 INFO - -d DEST, --destination=DEST 03:33:14 INFO - Directory to install application into. [default: 03:33:14 INFO - "/builds/slave/test"] 03:33:14 INFO - --app=APP Application being installed. [default: firefox] 03:33:14 INFO - mkdir: /builds/slave/test/build/application 03:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:30 INFO - Reading from file tmpfile_stdout 03:33:30 INFO - Output received: 03:33:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:30 INFO - Running post-action listener: _resource_record_post_action 03:33:30 INFO - ##### 03:33:30 INFO - ##### Finished install step (success) 03:33:30 INFO - ##### 03:33:30 INFO - ##### 03:33:30 INFO - ##### Running run-tests step. 03:33:30 INFO - ##### 03:33:30 INFO - Running pre-action listener: _resource_record_pre_action 03:33:30 INFO - Running main action method: run_tests 03:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:30 INFO - Python 2.7.3 03:33:30 INFO - Return code: 0 03:33:30 INFO - grabbing minidump binary from tooltool 03:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:30 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 0x1b931c0>, '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 0x1b940c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b94550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:33:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:33:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:30 INFO - Return code: 0 03:33:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:31 INFO - Return code: 0 03:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:33:31 INFO - mozversion application_buildid: 20160708004052 03:33:31 INFO - mozversion application_changeset: 00e9101b9ed0353afd4e7dd956a063d7ac511c91 03:33:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:31 INFO - mozversion application_name: Firefox 03:33:31 INFO - mozversion application_remotingname: firefox-dev 03:33:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:31 INFO - mozversion application_vendor: Mozilla 03:33:31 INFO - mozversion application_version: 49.0a2 03:33:31 INFO - mozversion platform_buildid: 20160708004052 03:33:31 INFO - mozversion platform_changeset: 00e9101b9ed0353afd4e7dd956a063d7ac511c91 03:33:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:31 INFO - mozversion platform_version: 49.0a2 03:33:31 INFO - using testdate: 1467974011 03:33:31 INFO - actual date: 1467974011 03:33:31 INFO - starting webserver on 'localhost:44017' 03:33:31 INFO - SUITE-START | Running 2 tests 03:33:31 INFO - TEST-START | dromaeo_css 03:33:31 INFO - operating with platform_type : linux_ 03:33:31 INFO - Initialising browser for dromaeo_css test... 03:33:31 INFO - TEST-INFO | started process 25824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YFPS5/profile http://localhost:44017/getInfo.html) 03:33:35 INFO - PROCESS | 25824 | __metrics Screen width/height:1600/1200 03:33:35 INFO - PROCESS | 25824 | colorDepth:24 03:33:35 INFO - PROCESS | 25824 | Browser inner width/height: 1024/697 03:33:35 INFO - PROCESS | 25824 | __metrics 03:33:36 ERROR - PROCESS | 25824 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:33:36 INFO - TEST-INFO | 25824: exit 0 03:33:36 INFO - Browser initialized. 03:33:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:36 INFO - TEST-INFO | started process 25953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YFPS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:48 INFO - PROCESS | 25953 | RSS: Main: 156209152 03:33:48 INFO - PROCESS | 25953 | 03:34:38 INFO - PROCESS | 25953 | 1467974078236 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:36:46 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44017/tests/dromaeo/cssquery-ext.html) 03:36:47 INFO - PROCESS | 25953 | RSS: Main: 159854592 03:36:47 INFO - PROCESS | 25953 | 03:39:49 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-ext.html (next: http://localhost:44017/tests/dromaeo/cssquery-jquery.html) 03:39:49 INFO - PROCESS | 25953 | RSS: Main: 157724672 03:39:49 INFO - PROCESS | 25953 | 03:42:51 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44017/tests/dromaeo/cssquery-mootools.html) 03:42:52 INFO - PROCESS | 25953 | RSS: Main: 157454336 03:42:52 INFO - PROCESS | 25953 | 03:45:53 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44017/tests/dromaeo/cssquery-prototype.html) 03:45:54 INFO - PROCESS | 25953 | RSS: Main: 157282304 03:45:54 INFO - PROCESS | 25953 | 03:48:56 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44017/tests/dromaeo/cssquery-yui.html) 03:48:57 INFO - PROCESS | 25953 | RSS: Main: 158883840 03:48:57 INFO - PROCESS | 25953 | 03:51:59 INFO - PROCESS | 25953 | Cycle 1(1): loaded http://localhost:44017/tests/dromaeo/cssquery-yui.html (next: http://localhost:44017/tests/dromaeo/cssquery-dojo.html) 03:52:00 INFO - PROCESS | 25953 | RSS: Main: 159346688 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | __start_tp_report 03:52:00 INFO - PROCESS | 25953 | _x_x_mozilla_page_load 03:52:00 INFO - PROCESS | 25953 | _x_x_mozilla_page_load_details 03:52:00 INFO - PROCESS | 25953 | |i|pagename|runs| 03:52:00 INFO - PROCESS | 25953 | |0;dojo.html;3263.820489873057;3340.0313908966396;3350.865965361386;3369.090345606685;3374.342003309354;5555.112219451372;5601.29983752031;5606.55147588193;5622.297212848394;5632.831015069544;5592.412796656344;5639.238702775124;5657.9434205658035;5667.943320566793;5678.205051292823;5054.949450505503;5137.101007323722;5168.457311982244;5183.688978661274;5185.844424667266;5043.470435604246;5069.214271787879;5209.1404918188455;5217.3217481727515;5243.632945693803;5107.336046313974;5109.514596113363;5116.846494605168;5158.48415158483;5172.482751724835;5099.872503187431;5205.947940520584;5206.973965130188;5207.687538747668;5238.554722848562;4895.069936712013;5043.9747801260755;5112.872178195537;5158.277841102249;5181.145111056671;5408.242846001563;5475.151351540518;5478.91781623276;5545.417731138213;5573.41479144692;6000.099985002241;6036.667983260919;6042.607230530046;6044.879102417971;6057.394260573951;5886.529077673776;5962.850928726773;6101.816945491642;6105.786297479612;6110.08348747687;5524.8342549723575;5656.1798539211995;5686.829395118153;5688.488036076732;5710.200571919934;6197.163382943335;6216.191895053614;6225.906611400833;6229.159063526366;6231.065340199007;5746.080627099644;5841.88316233673;5865.266841644794;5943.435373639497;5959.910601340984;6017.157597936292;6030.095485677183;6035.245594300713;6045.21412216409;6092.147099406086;5972;5985.191999080155;6006.909896351558;6015.3383127855905;6035.064564992434;5742.712864356766;5922.496587790086;5936.347001829795;5992.43071908168;6008;4673.906521869543;4675.22858728306;4680.695754775928;4686.882827929329;4697.929531057037;4185.476815398075;4194.077302993336;4197.370394440858;4209.873703788891;4241.491021077491;5403.702796346239;5682.516986056232;5697.4587414195585;5741.598088133791;5787.88424231513;5908.822735317947;5914.645121292736;6004.189434426384;6030.216071910623;6031.185789918305;5579.107342825209;5739.913901291484;5741.827745167651;5743.339515955635;5761.279840019997;5094.898102038012;5096.184610462308;5128.589712822965;5155.458676838878;5164.8192313268855;6084.6349219047;6104.4505994460715;6138.631682098999;6144.41628045335;6146.385361463907;5810.6513609183585;5899.439553242435;5989.520838332923;6013.759449621966;6015.157877897185;6044.032954727222;6120.90429240112;6121.767558219948;6125.572745538934;6130.948521379913;5885.529157667462;5887.911681324698;5888.087346461305;5907.734151963258;5914.994450943436;5768.105943578752;5951.285845698544;5967.880642387041;5982.850428739316;6002.129691194839;5857.648541087548;5898.764049437975;5948.524118070631;5956.821295361146;5978.581499295182;5861.413858614104;5901.940980590139;5917.053271476543;5918.319393269657;5926.851828704144;5584.553235741212;5697.487226149667;5709.65742055478;5753.280839895013;5767.596268261349;5861.267341582302;5894.528437724886;5913.29040515141;5930.970345148419;5949.3753155918;5759.827205183851;5803;5812.593118481835;5813.505852002458;5817.970910145592 03:52:00 INFO - PROCESS | 25953 | |1;ext.html;583.9124131380293;638.5434414393709;639.6833567384145;658.052404537466;662.3409707341193;34688.653113468856;46263.53736462635;47777.28334074992;47865;47886.52113478864;49929;50586.49413505864;50603;50612.49387506124;50714.746426267906;9010.053944335832;9115.361924665276;9116.8632470513;9122.179003889649;9173.54132293386;8821.735347939572;8931.642734290654;8935.508547029911;8959;8968.237699795525;9041.502717350542;9045.457272563634;9057.320700947423;9095.909040909606;9105.499197544132;8923.821523569524;9001.909980900173;9023.18791308782;9039.322050846213;9048.683296084606;8938.64245430182;9009.864852027225;9010.098990101003;9012.549372531346;9017.458952462874;46629.533704662856;46877.765611172064;47045.05909881783;47095;47096.76451617754;3786.772793632391;3863.806809659534;3867.1878905429894;3881.844726210948;3932.7247092703524;34892.47661285083;35171.4724279136;35237;35288.11779705502;35352.46971295433;4603.309503574457;4761.738104404257;4817.301491283779;4885.169521181372;4917.975410122962;375777;379950;382943;383251;384948;38899.61100389017;65282.36794080091;65743.34256657468;65930.34069659338;66042.66978665076;39663.80168099141;40580.59419405827;40673.18653626911;40981.590184097775;41023.794881026;16574.337026518806;16696.081715505763;16769.580760481087;16775;16789.91605041967;14807.777883331759;14823.851761482463;14826.62933426673;14980.475683351031;14988.47540336083;9109.77225569366;9195.402298850553;9205.953970230106;9219.861702074475;9244.491552964517;3484.181217413906;3485.634008429078;3503.597086335053;3508.8947331580093;3561.4479755637917;1114.637742733615;1162.9883701163048;1178.4107946026986;1180.7520420711746;1214.5566868093083;34894.12764680853;35128.47307290393;37053.07367315785;37392.62607373892;38030.809845951146;1213.205350495427;1222.743223922986;1223.3027174510444;1228.8709685482895;1248.4257241668934;17627;17735.46793596194;17790.644187116184;17843.286268549113;18010.459686209433;567132;573534;576170;581290;668415;64637.35362646407;64977.675111624136;65241.673791631685;65293;65522.672386637765;1474.5944865162166;1502.774583812415;1507.0882116319688;1507.4422463688286;1530.8851836112335;33820.3235935275;33978;34137.82931085329;34425.65574344325;34759.652403476655;56427.71786141043;57142.7142864283;57370;57586.42413575978;57664;542523;557260;557434;559617;559872;31742.36515269728;32101;32147.839260803546;32156.356872862878;32190.83904580462;52016.21975670292;52656.47343526669;52727.73636131795;53077;53155.73422132865;42807.35788963106;43867.341989869536;44075;44457.33314000228;44957.775211123735;43041.569584305005;43899.12201756011;44348;44935;45008.77495612501;43131.353029703954;44243.778781107176;44709.32936006028;44864;45132.77433612811;38317;38371.6162838368;38487.79049722436;38698.80650596729;39322;29720.554191686708;29837;29962.25094372658;30021.24946876258;30390.088297351114 03:52:00 INFO - PROCESS | 25953 | |2;jquery.html;410.46639368820536;420.87373787863635;423.57430782064023;423.758457679123;432.9242382583049;18865.622687546256;19650.7052394214;20481.07835147418;21094.472638184016;21109.788902110973;18365.44903652889;19272.22911083555;19397.224111035543;19618.607627847436;20202;5195.688258704471;5331.946680533184;5346.064438723227;5346.625736198448;5347.652402593819;5279.947200528003;5495.313085864267;5801.187833703285;5822.301323841145;5863.208466856983;5621.437856214387;5834.679092649923;5871.324797648261;6024.066269728177;6026.306974697922;5927.2887253529425;5958.97020514899;6007.339192688801;6013.398660133996;6028.5478589106;5754.338251101135;5797.768089276424;5898.941010589882;5943.3462319144855;5986.820395388146;20195.788252704737;23331.766682333127;24149.275521734377;24234.87882560576;24295.878520607283;2440.2801173653816;2491.302435318114;2506.4611108611552;2510.3096648421647;2703.4187649655223;10808.675739727822;10874.565017399294;10889.074428673572;12744.490220391173;15370.693491053275;2042.5812708394744;2069.4205622425743;2104.970095901928;2126.5853158634072;2151.601953638582;81037.18962810414;82346.58826705888;84085.15914840835;85139.5743021281;85768;11592.942035289769;11612.535498580131;11830.112741544419;11918.880811191777;11926.940365298291;14619.707605848036;16706;16747.748783768253;16846.073465959245;16912.57718557021;8333.874991875127;8738.825223495494;8889.066648001995;9131.086891310815;9228.215601673934;8986.505742184112;9037.322200834964;9055.320850936207;9056.275497960147;9209.539523023823;4939.975300123549;5085.74571271435;5103.515166059218;5162.45794191612;5162.767675454614;2063.123172651617;2105.3999610111046;2122.4163355077476;2123.830093592509;2138.582976319634;1004.5730564510054;1100.6477927063422;1102.3385968419045;1107.9723006924892;1142.8342890281028;17681.557961051076;19070;19894.403167904988;19896.403107906786;20230;1073.9677809665723;1087.3312912558877;1090.6346373964811;1118.8825173356843;1141.4064686363045;10988;11038.7857335693;11063.336199828036;11230.66308010761;11263.380514071805;541012;544575;556649;558742;560408;52250.47749522532;74533.627331863;100539;101459.49270253601;101703;1092.5247517329988;1094.3488624268548;1102.9742339624227;1106.6679996001328;1118.5637601335486;17446.825531745028;17562.473125806246;17933.219764883757;18084;18133.093345332418;33161.336773263916;41026.17947640971;41423;42458.57541424546;43692.34461483017;57729.422705774086;59019.704901476936;59446.70276648589;60085;60201;9022.413543119676;9074;9133.634654613741;9136.862947055666;9325.766855828659;9892.604295828374;14154;14256.786148207577;14359.856401435853;14370.281485925452;12223.69440763988;12469.127161098637;12473.251604903735;12561.685957851127;12722.236665800081;6828.760993365408;11194;12198.390080495763;12301.815472768094;12559;12040.21738586989;12606;12662.746745065231;12842.229466232056;12923.22460652364;9088.136627020422;9171.908280917105;9193.942696589978;9267.165955064076;9304.95347523285;10800.94492104936;11892;12060.939695301468;12201.389930503261;12249.713780052965 03:52:00 INFO - PROCESS | 25953 | |3;mootools.html;1558.2831897327228;1583.1451016451115;1816.26441291277;1893.5550145715754;1910.0640686063832;8380.497170169794;9232.353735238528;9312.906870931289;10049.04534069264;10052.748681282972;9366.531673416335;9694.56374463149;9773.706788796348;9781.7554561136;9810.705678829629;2409.6987876515436;2416.069813121952;2445.119756887519;2449.6570480132796;2455.484348286862;2391.8804059797026;2422.2612103308484;2423.866687332196;2424.2969538833718;2430.6232533957264;2338.3218866528687;2366.25462979161;2369.3839601703507;2379.9171377023413;2383.535210633927;2216.822654187661;2237.7762223777654;2238.5858616156065;2244.2481768607454;2295.758945310735;2283.246528645543;2323.59337116004;2324.37241944674;2328.2316835444262;2328.685627440291;9718.31971761977;9796.804063918753;9822.508874556315;9832;9832.803343933081;5606.607537472379;5752.395998420147;5758.596898217126;5769.624974376652;5787.797427090031;3556;3565.144365352297;3650.3246899323444;3661.2677464506937;3673.687736542397;1194.7252132009598;1196.347990345264;1216.6106845809345;1231.9568815091518;1240.6774238697913;13858.584242472742;13912.791308130387;13926.791098133535;14043.929780351033;14100.08349457282;4751.287306903992;4840.661153719206;4891.095147397743;4904.60763138948;4928.310036594879;10678.73303167427;10759.623413180501;10852.294600850919;10877.184211184192;10920.890791092146;5622.887542249132;5654.9151762723595;5680.687562184037;5703.828885133453;5706.828795136153;4576.290674945389;5086.821961231339;5212.139996900469;5219.451957544403;5230.320058392461;4054.6958978076173;4110.203096444995;4143.316352801754;4192.266353388145;4207.0954744729415;1203.3501908969058;1232.5932442294022;1234.6789834643057;1245.1470742541387;1250.93745312734;959.9520023998912;985.6648739428485;1048.2766890845292;1055.7044027672264;1059.046857827961;6393.041043843367;6445.258795238514;6508.739650414025;6604.570702904296;6619.338066193439;455.769836232707;466.6080492386412;470.82814772608435;474.6250462134944;486.093435742338;4600.171969045604;4600.401947746838;4606.124836281096;4616.930746038812;4630.4443466784205;11507.539698411969;12182;12617.432215550321;12623.684407889876;12637.873621263854;11788.351640659846;12074.517019319304;12139;12356.38218089092;12365.443555040045;8903.510306933182;8952.68665596701;8977.416467929565;9022.819543609092;9076.455412675261;6522.673866306571;6644.468442524683;6718.630475323904;6838.726450942106;6908.067410899665;11096.944515277371;11161.553537858395;11221.102311815199;11346.638403391316;11568.132390070947;11544.307341559534;11680;11705.707357315794;11708.88291117112;11759.353235572125;8717.564121794012;8736.56317184151;8772.868406973774;8893.199612034949;8896.065913079034;9308.208802251884;9371.109744574254;9395.577199025924;9429;9516.524173791422;8701.869471958053;8703.608337624948;8741.213290803604;8752.387332886638;8760.956195219238;8382.874256886274;8423.284020858297;8466.111058339033;8468.872966905625;8596.957015214884;7762.650680719494;7827.6868925244635;7888.605569721606;7899.68401263966;7932.405069619917;5673.943260567342;5675.744591493475;5772.682502462405;5774.538036956949;5776;5520.171974203901;5634.352049514195;5653.858653533694;5655.773769049192;5751.1373294006235 03:52:00 INFO - PROCESS | 25953 | |4;prototype.html;331.6451397005204;345.8720273498805;347.63498326756905;349.7806418276041;354.34976817539814;5569.777208911649;5672.858178545538;5674.858128546778;5684.602077854552;5703.173039909216;5584.497395234428;5598.440155984399;5601.915971260434;5622.578306627009;5630.1554766785;4373.497047839507;4390.956090439095;4397.868063958071;4400.537943515933;4403.691741578091;4247.897290841038;4343.9348409773875;4375.234333991555;4390.187815254172;4440.933385999197;4268.957310426903;4294;4315.805788739514;4322.82708691652;4333.371661109138;4296.248156572603;4350.564943505624;4353.10761293934;4394.78026098697;4407.559244075599;3709.5919448860604;3845.7115716321387;3860.8455661773496;3862.7102967277287;3865.7487263328076;5338.599605029638;5363.731813409314;5380.21986811914;5387.164989426645;5422.2951016368015;4914.336564563774;4928.472173626152;4980.327655766498;4984;4998.975005124988;5664.422687677097;5816;5872;5879.029960056586;5921.348651648315;4169.687273454503;4179.582041795827;4197.748135111872;4198.265303571863;4209.6000879916355;6084;6091.908621370683;6108.511319094462;6127.6017058891475;6163.1679723237685;4023.4970628671417;4288.399624052635;4325.264705000158;4328.848490302824;4347.06538094305;4316.093620339764;4328.675349348811;4344.47866256045;4354.6951713380395;4407.669424793154;4946.752662366867;4981.501849814989;4986.850394488171;5007.39911210657;5036.445990940993;5597.216389705444;5903.9668058089665;5914.556408269397;5920.970395147997;5921.2302400688495;1476.5201309574215;1490.3219035338896;1498.655309278872;1498.8576085271882;1502.143778046503;939.8073394954018;947.545178314413;955.8948515663271;961.9422834629804;976.5068640336584;5076.466970968069;5080.441151473335;5105.7191854448365;5118.87202819925;5124.027249508966;5425;5442.6462279951675;5460.972695136578;5479.479449452296;5516.282883225155;5013.573846223112;5062.557171206188;5105.310783044241;5149.407818100966;5217.530422262014;2831.631887854566;2865.957010644842;2875.6549214094443;2882.610847535556;2889.8699558519916;5407;5448.101063324507;5513.558915286768;5558.471945165203;5579.9163012554845;5190.844274671766;5430.91853622196;5453.182022696627;5454.3454785426;5472.425395333512;5417.160340147283;5455.699936503531;5460.726963651881;5471.534919531884;5572.972135139298;4997.475265097258;5355.892882142413;5356.767943372968;5395.2176934343515;5408.837734867803;5244.898571300069;5276.577873770166;5295.629305948547;5302.787888484418;5305.9204111939125;5411.538884501084;5430.755615997211;5438.782448702008;5462.289902312674;5865.824025279248;4116.91766164669;4248.34150706641;4258.276093064249;4263.914721705486;4280.571942805695;5927.881442371042;5971.731272092679;5974.37269086757;6001.639901605918;6005.849853753691;5641.492265696107;5794.652320860761;5818.505427038749;5828.484594005505;5833.979053665506;5720.713964301685;5729.570282228933;5771.682557459212;5787.119186264396;5809.157672137601;5717.656940583578;5732.627379220337;5737.827865164052;5744;5810.215620891126;5629.54963602919;5831.862786756542;5869.6771677558145;5881.647101173943;5888.528917686489;5679.77280908759;5718.428157184248;5727.885442291047;5779.335376431764;5791.218185544897 03:52:00 INFO - PROCESS | 25953 | |5;yui.html;734.9191588925218;749.955002699838;766.0462723908735;797.3621103117506;883.434601854813;15561.533154005383;15715.921420392911;15745.84254157458;15799.605009874731;16102.597435064115;15397.384104635828;15556.45552405666;15683.84316156838;15697.607559811011;15701.214939253021;724.5000949344949;829.1211316005054;848.6435697007241;849.9192576705203;854.2909385210291;866.3891956170916;867.9132086791302;870.83889480446;871.8866547348836;872.8123453457505;908.5321059654283;911.0752586125088;912.1425859691868;916.8533034714447;917.2845180758985;907.0702529906832;908.3686837647838;910.7540963939732;911.5168960450972;912.3567884641345;667.6995352091578;669.7655820462799;670.4133882852504;671.3990978074596;671.8992151177314;15129.621759455991;15136.470223542234;15252.923735381251;15265.160416177107;15306.540803775904;15970.829716976436;16633;16639.25123369451;16644.33422663092;16657.91671041649;12337.561765249591;12374.75250494994;12424.627261182179;12600.243985360908;12699;4103.671706263492;4126.216018956388;4156.981539522836;4290.549492303295;4307.246231909403;69733.30266697319;79416.60291698505;80162.19837801605;81143.18856811474;82033.17966820316;12108.515659373703;12546.372681365896;12589.181703189446;12603.621891343275;12828.29444380568;22401.551968960528;22420.215292464687;22424.766637835077;22467.775322246896;22510.774892251196;9240.768980775534;9379.108984646447;9444.8583271251;9809.754756131153;9845.163161131384;5208.9739551302755;5221.973890130525;5239.947600524022;5313.654612450178;5323;3835.5972622874756;3966.484357033567;3971.285168669667;4008.0581063450068;4141.109661422808;754.9584772837437;773.2576726342774;782.335015237044;784.3920961254959;787.79123532264;685.533836990841;742.2911119880501;770.4799260499141;785.615048626169;797.4975765267844;10287.22845786554;10720.946395267974;10842.241043126905;10932.617358392417;11034.613788517523;735.577043200162;745.0388998192379;787.3425689549176;803.5901690138072;815.995920020396;4962.230854217602;5000.449950505442;5069.898602027939;5085.771140298695;5163.586913046947;120561;124404;126025;127338;127434;106502.46748766207;108011.45994269979;110455;110625;115043.42478287722;80733;88281;90388.5480572606;91093;93172.53413732888;9650.179734722627;9835.901640983499;9948.850767238642;10001.5499302533;10031.648892288735;38779.61220387873;41721.58278417177;55606.16590751061;56008.15987760268;56043.439565603825;68851.65574172097;69813.65093174501;71135.28864711287;76366.61816690881;82086.17913821024;13337.466501340226;13343.733125337632;13520.661983450493;13530;14380.640483987983;14355.138691678532;14555.345009474811;14654.194019328614;14669.779953300496;14827.92586037063;13002.219866808022;13402.798958015832;13735.862641373858;14210.644733881736;14545.563633091024;12939.870601293867;12979.221246725227;12982.80525792095;13020.674483137997;13402.93298533501;13052.477900883858;13263.137896036727;13589.932050339685;13670.11144275619;13840.93079534596;10704.571817127538;10764.246502744732;10872.238943274211;10922.126229901747;10943.45282735876;11364.279859920887;11372.60195893173;11921.165518413974;11966;12125.454354553889 03:52:00 INFO - PROCESS | 25953 | __end_tp_report 03:52:00 INFO - PROCESS | 25953 | __start_cc_report 03:52:00 INFO - PROCESS | 25953 | _x_x_mozilla_cycle_collect,330 03:52:00 INFO - PROCESS | 25953 | __end_cc_report 03:52:00 INFO - PROCESS | 25953 | __startTimestamp1467975120038__endTimestamp 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | ------- Summary: start ------- 03:52:00 INFO - PROCESS | 25953 | Number of tests: 6 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#0] dojo.html Cycles:165 Average:5581.82 Median:5768.11 stddev:603.58 (10.5%) stddev-sans-first:577.38 03:52:00 INFO - PROCESS | 25953 | Values: 3263.8 3340.0 3350.9 3369.1 3374.3 5555.1 5601.3 5606.6 5622.3 5632.8 5592.4 5639.2 5657.9 5667.9 5678.2 5054.9 5137.1 5168.5 5183.7 5185.8 5043.5 5069.2 5209.1 5217.3 5243.6 5107.3 5109.5 5116.8 5158.5 5172.5 5099.9 5205.9 5207.0 5207.7 5238.6 4895.1 5044.0 5112.9 5158.3 5181.1 5408.2 5475.2 5478.9 5545.4 5573.4 6000.1 6036.7 6042.6 6044.9 6057.4 5886.5 5962.9 6101.8 6105.8 6110.1 5524.8 5656.2 5686.8 5688.5 5710.2 6197.2 6216.2 6225.9 6229.2 6231.1 5746.1 5841.9 5865.3 5943.4 5959.9 6017.2 6030.1 6035.2 6045.2 6092.1 5972.0 5985.2 6006.9 6015.3 6035.1 5742.7 5922.5 5936.3 5992.4 6008.0 4673.9 4675.2 4680.7 4686.9 4697.9 4185.5 4194.1 4197.4 4209.9 4241.5 5403.7 5682.5 5697.5 5741.6 5787.9 5908.8 5914.6 6004.2 6030.2 6031.2 5579.1 5739.9 5741.8 5743.3 5761.3 5094.9 5096.2 5128.6 5155.5 5164.8 6084.6 6104.5 6138.6 6144.4 6146.4 5810.7 5899.4 5989.5 6013.8 6015.2 6044.0 6120.9 6121.8 6125.6 6130.9 5885.5 5887.9 5888.1 5907.7 5915.0 5768.1 5951.3 5967.9 5982.9 6002.1 5857.6 5898.8 5948.5 5956.8 5978.6 5861.4 5901.9 5917.1 5918.3 5926.9 5584.6 5697.5 5709.7 5753.3 5767.6 5861.3 5894.5 5913.3 5931.0 5949.4 5759.8 5803.0 5812.6 5813.5 5818.0 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#1] ext.html Cycles:180 Average:66892.81 Median:44583.33 stddev:138140.56 (309.8%) stddev-sans-first:138438.36 03:52:00 INFO - PROCESS | 25953 | Values: 583.9 638.5 639.7 658.1 662.3 34688.7 46263.5 47777.3 47865.0 47886.5 49929.0 50586.5 50603.0 50612.5 50714.7 9010.1 9115.4 9116.9 9122.2 9173.5 8821.7 8931.6 8935.5 8959.0 8968.2 9041.5 9045.5 9057.3 9095.9 9105.5 8923.8 9001.9 9023.2 9039.3 9048.7 8938.6 9009.9 9010.1 9012.5 9017.5 46629.5 46877.8 47045.1 47095.0 47096.8 3786.8 3863.8 3867.2 3881.8 3932.7 34892.5 35171.5 35237.0 35288.1 35352.5 4603.3 4761.7 4817.3 4885.2 4918.0 375777.0 379950.0 382943.0 383251.0 384948.0 38899.6 65282.4 65743.3 65930.3 66042.7 39663.8 40580.6 40673.2 40981.6 41023.8 16574.3 16696.1 16769.6 16775.0 16789.9 14807.8 14823.9 14826.6 14980.5 14988.5 9109.8 9195.4 9206.0 9219.9 9244.5 3484.2 3485.6 3503.6 3508.9 3561.4 1114.6 1163.0 1178.4 1180.8 1214.6 34894.1 35128.5 37053.1 37392.6 38030.8 1213.2 1222.7 1223.3 1228.9 1248.4 17627.0 17735.5 17790.6 17843.3 18010.5 567132.0 573534.0 576170.0 581290.0 668415.0 64637.4 64977.7 65241.7 65293.0 65522.7 1474.6 1502.8 1507.1 1507.4 1530.9 33820.3 33978.0 34137.8 34425.7 34759.7 56427.7 57142.7 57370.0 57586.4 57664.0 542523.0 557260.0 557434.0 559617.0 559872.0 31742.4 32101.0 32147.8 32156.4 32190.8 52016.2 52656.5 52727.7 53077.0 53155.7 42807.4 43867.3 44075.0 44457.3 44957.8 43041.6 43899.1 44348.0 44935.0 45008.8 43131.4 44243.8 44709.3 44864.0 45132.8 38317.0 38371.6 38487.8 38698.8 39322.0 29720.6 29837.0 29962.3 30021.2 30390.1 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#2] jquery.html Cycles:180 Average:30973.22 Median:2145.09 stddev:90700.83 (4228.3%) stddev-sans-first:90926.24 03:52:00 INFO - PROCESS | 25953 | Values: 410.5 420.9 423.6 423.8 432.9 18865.6 19650.7 20481.1 21094.5 21109.8 18365.4 19272.2 19397.2 19618.6 20202.0 5195.7 5331.9 5346.1 5346.6 5347.7 5279.9 5495.3 5801.2 5822.3 5863.2 5621.4 5834.7 5871.3 6024.1 6026.3 5927.3 5959.0 6007.3 6013.4 6028.5 5754.3 5797.8 5898.9 5943.3 5986.8 20195.8 23331.8 24149.3 24234.9 24295.9 2440.3 2491.3 2506.5 2510.3 2703.4 10808.7 10874.6 10889.1 12744.5 15370.7 2042.6 2069.4 2105.0 2126.6 2151.6 81037.2 82346.6 84085.2 85139.6 85768.0 11592.9 11612.5 11830.1 11918.9 11926.9 14619.7 16706.0 16747.7 16846.1 16912.6 8333.9 8738.8 8889.1 9131.1 9228.2 8986.5 9037.3 9055.3 9056.3 9209.5 4940.0 5085.7 5103.5 5162.5 5162.8 2063.1 2105.4 2122.4 2123.8 2138.6 1004.6 1100.6 1102.3 1108.0 1142.8 17681.6 19070.0 19894.4 19896.4 20230.0 1074.0 1087.3 1090.6 1118.9 1141.4 10988.0 11038.8 11063.3 11230.7 11263.4 541012.0 544575.0 556649.0 558742.0 560408.0 52250.5 74533.6 100539.0 101459.5 101703.0 1092.5 1094.3 1103.0 1106.7 1118.6 17446.8 17562.5 17933.2 18084.0 18133.1 33161.3 41026.2 41423.0 42458.6 43692.3 57729.4 59019.7 59446.7 60085.0 60201.0 9022.4 9074.0 9133.6 9136.9 9325.8 9892.6 14154.0 14256.8 14359.9 14370.3 12223.7 12469.1 12473.3 12561.7 12722.2 6828.8 11194.0 12198.4 12301.8 12559.0 12040.2 12606.0 12662.7 12842.2 12923.2 9088.1 9171.9 9193.9 9267.2 9305.0 10800.9 11892.0 12060.9 12201.4 12249.7 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#3] mootools.html Cycles:180 Average:6365.53 Median:4623.69 stddev:3756.83 (81.3%) stddev-sans-first:3750.00 03:52:00 INFO - PROCESS | 25953 | Values: 1558.3 1583.1 1816.3 1893.6 1910.1 8380.5 9232.4 9312.9 10049.0 10052.7 9366.5 9694.6 9773.7 9781.8 9810.7 2409.7 2416.1 2445.1 2449.7 2455.5 2391.9 2422.3 2423.9 2424.3 2430.6 2338.3 2366.3 2369.4 2379.9 2383.5 2216.8 2237.8 2238.6 2244.2 2295.8 2283.2 2323.6 2324.4 2328.2 2328.7 9718.3 9796.8 9822.5 9832.0 9832.8 5606.6 5752.4 5758.6 5769.6 5787.8 3556.0 3565.1 3650.3 3661.3 3673.7 1194.7 1196.3 1216.6 1232.0 1240.7 13858.6 13912.8 13926.8 14043.9 14100.1 4751.3 4840.7 4891.1 4904.6 4928.3 10678.7 10759.6 10852.3 10877.2 10920.9 5622.9 5654.9 5680.7 5703.8 5706.8 4576.3 5086.8 5212.1 5219.5 5230.3 4054.7 4110.2 4143.3 4192.3 4207.1 1203.4 1232.6 1234.7 1245.1 1250.9 960.0 985.7 1048.3 1055.7 1059.0 6393.0 6445.3 6508.7 6604.6 6619.3 455.8 466.6 470.8 474.6 486.1 4600.2 4600.4 4606.1 4616.9 4630.4 11507.5 12182.0 12617.4 12623.7 12637.9 11788.4 12074.5 12139.0 12356.4 12365.4 8903.5 8952.7 8977.4 9022.8 9076.5 6522.7 6644.5 6718.6 6838.7 6908.1 11096.9 11161.6 11221.1 11346.6 11568.1 11544.3 11680.0 11705.7 11708.9 11759.4 8717.6 8736.6 8772.9 8893.2 8896.1 9308.2 9371.1 9395.6 9429.0 9516.5 8701.9 8703.6 8741.2 8752.4 8761.0 8382.9 8423.3 8466.1 8468.9 8597.0 7762.7 7827.7 7888.6 7899.7 7932.4 5673.9 5675.7 5772.7 5774.5 5776.0 5520.2 5634.4 5653.9 5655.8 5751.1 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#4] prototype.html Cycles:180 Average:4759.53 Median:5371.98 stddev:1368.37 (25.5%) stddev-sans-first:1331.24 03:52:00 INFO - PROCESS | 25953 | Values: 331.6 345.9 347.6 349.8 354.3 5569.8 5672.9 5674.9 5684.6 5703.2 5584.5 5598.4 5601.9 5622.6 5630.2 4373.5 4391.0 4397.9 4400.5 4403.7 4247.9 4343.9 4375.2 4390.2 4440.9 4269.0 4294.0 4315.8 4322.8 4333.4 4296.2 4350.6 4353.1 4394.8 4407.6 3709.6 3845.7 3860.8 3862.7 3865.7 5338.6 5363.7 5380.2 5387.2 5422.3 4914.3 4928.5 4980.3 4984.0 4999.0 5664.4 5816.0 5872.0 5879.0 5921.3 4169.7 4179.6 4197.7 4198.3 4209.6 6084.0 6091.9 6108.5 6127.6 6163.2 4023.5 4288.4 4325.3 4328.8 4347.1 4316.1 4328.7 4344.5 4354.7 4407.7 4946.8 4981.5 4986.9 5007.4 5036.4 5597.2 5904.0 5914.6 5921.0 5921.2 1476.5 1490.3 1498.7 1498.9 1502.1 939.8 947.5 955.9 961.9 976.5 5076.5 5080.4 5105.7 5118.9 5124.0 5425.0 5442.6 5461.0 5479.5 5516.3 5013.6 5062.6 5105.3 5149.4 5217.5 2831.6 2866.0 2875.7 2882.6 2889.9 5407.0 5448.1 5513.6 5558.5 5579.9 5190.8 5430.9 5453.2 5454.3 5472.4 5417.2 5455.7 5460.7 5471.5 5573.0 4997.5 5355.9 5356.8 5395.2 5408.8 5244.9 5276.6 5295.6 5302.8 5305.9 5411.5 5430.8 5438.8 5462.3 5865.8 4116.9 4248.3 4258.3 4263.9 4280.6 5927.9 5971.7 5974.4 6001.6 6005.8 5641.5 5794.7 5818.5 5828.5 5834.0 5720.7 5729.6 5771.7 5787.1 5809.2 5717.7 5732.6 5737.8 5744.0 5810.2 5629.5 5831.9 5869.7 5881.6 5888.5 5679.8 5718.4 5727.9 5779.3 5791.2 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - PROCESS | 25953 | [#5] yui.html Cycles:180 Average:21764.35 Median:3989.67 stddev:31802.70 (797.1%) stddev-sans-first:31852.71 03:52:00 INFO - PROCESS | 25953 | Values: 734.9 750.0 766.0 797.4 883.4 15561.5 15715.9 15745.8 15799.6 16102.6 15397.4 15556.5 15683.8 15697.6 15701.2 724.5 829.1 848.6 849.9 854.3 866.4 867.9 870.8 871.9 872.8 908.5 911.1 912.1 916.9 917.3 907.1 908.4 910.8 911.5 912.4 667.7 669.8 670.4 671.4 671.9 15129.6 15136.5 15252.9 15265.2 15306.5 15970.8 16633.0 16639.3 16644.3 16657.9 12337.6 12374.8 12424.6 12600.2 12699.0 4103.7 4126.2 4157.0 4290.5 4307.2 69733.3 79416.6 80162.2 81143.2 82033.2 12108.5 12546.4 12589.2 12603.6 12828.3 22401.6 22420.2 22424.8 22467.8 22510.8 9240.8 9379.1 9444.9 9809.8 9845.2 5209.0 5222.0 5239.9 5313.7 5323.0 3835.6 3966.5 3971.3 4008.1 4141.1 755.0 773.3 782.3 784.4 787.8 685.5 742.3 770.5 785.6 797.5 10287.2 10720.9 10842.2 10932.6 11034.6 735.6 745.0 787.3 803.6 816.0 4962.2 5000.4 5069.9 5085.8 5163.6 120561.0 124404.0 126025.0 127338.0 127434.0 106502.5 108011.5 110455.0 110625.0 115043.4 80733.0 88281.0 90388.5 91093.0 93172.5 9650.2 9835.9 9948.9 10001.5 10031.6 38779.6 41721.6 55606.2 56008.2 56043.4 68851.7 69813.7 71135.3 76366.6 82086.2 13337.5 13343.7 13520.7 13530.0 14380.6 14355.1 14555.3 14654.2 14669.8 14827.9 13002.2 13402.8 13735.9 14210.6 14545.6 12939.9 12979.2 12982.8 13020.7 13402.9 13052.5 13263.1 13589.9 13670.1 13840.9 10704.6 10764.2 10872.2 10922.1 10943.5 11364.3 11372.6 11921.2 11966.0 12125.5 03:52:00 INFO - PROCESS | 25953 | -------- Summary: end -------- 03:52:00 INFO - PROCESS | 25953 | 03:52:00 INFO - TEST-INFO | 25953: exit 0 03:52:00 INFO - TEST-OK | dromaeo_css | took 1109311ms 03:52:00 INFO - TEST-START | kraken 03:52:00 INFO - operating with platform_type : linux_ 03:52:00 INFO - Initialising browser for kraken test... 03:52:00 INFO - TEST-INFO | started process 26203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYzWADV/profile http://localhost:44017/getInfo.html) 03:52:04 INFO - PROCESS | 26203 | __metrics Screen width/height:1600/1200 03:52:04 INFO - PROCESS | 26203 | colorDepth:24 03:52:04 INFO - PROCESS | 26203 | Browser inner width/height: 1024/697 03:52:04 INFO - PROCESS | 26203 | __metrics 03:52:05 ERROR - PROCESS | 26203 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:52:05 INFO - TEST-INFO | 26203: exit 0 03:52:05 INFO - Browser initialized. 03:52:05 INFO - Running cycle 1/1 for kraken test... 03:52:05 INFO - TEST-INFO | started process 26335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYzWADV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:17 INFO - PROCESS | 26335 | RSS: Main: 156340224 03:52:17 INFO - PROCESS | 26335 | 03:52:20 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44017/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:21 INFO - PROCESS | 26335 | RSS: Main: 161189888 03:52:21 INFO - PROCESS | 26335 | 03:52:23 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44017/tests/kraken/driver.html?testName=audio-dft) 03:52:24 INFO - PROCESS | 26335 | RSS: Main: 160997376 03:52:24 INFO - PROCESS | 26335 | 03:52:27 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44017/tests/kraken/driver.html?testName=audio-fft) 03:52:27 INFO - PROCESS | 26335 | RSS: Main: 161816576 03:52:27 INFO - PROCESS | 26335 | 03:52:29 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44017/tests/kraken/driver.html?testName=audio-oscillator) 03:52:30 INFO - PROCESS | 26335 | RSS: Main: 160821248 03:52:30 INFO - PROCESS | 26335 | 03:52:32 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:33 INFO - PROCESS | 26335 | RSS: Main: 160575488 03:52:33 INFO - PROCESS | 26335 | 03:52:36 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44017/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:36 INFO - PROCESS | 26335 | RSS: Main: 160993280 03:52:36 INFO - PROCESS | 26335 | 03:52:40 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44017/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:41 INFO - PROCESS | 26335 | RSS: Main: 157278208 03:52:41 INFO - PROCESS | 26335 | 03:52:43 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44017/tests/kraken/driver.html?testName=json-parse-financial) 03:52:44 INFO - PROCESS | 26335 | RSS: Main: 160092160 03:52:44 INFO - PROCESS | 26335 | 03:52:46 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:46 INFO - PROCESS | 26335 | RSS: Main: 159625216 03:52:46 INFO - PROCESS | 26335 | 03:52:48 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:49 INFO - PROCESS | 26335 | RSS: Main: 159580160 03:52:49 INFO - PROCESS | 26335 | 03:52:51 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:51 INFO - PROCESS | 26335 | RSS: Main: 160591872 03:52:51 INFO - PROCESS | 26335 | 03:52:54 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:54 INFO - PROCESS | 26335 | RSS: Main: 160571392 03:52:54 INFO - PROCESS | 26335 | 03:52:57 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:58 INFO - PROCESS | 26335 | RSS: Main: 160219136 03:52:58 INFO - PROCESS | 26335 | 03:52:59 INFO - PROCESS | 26335 | Cycle 1(1): loaded http://localhost:44017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44017/tests/kraken/driver.html?testName=ai-astar) 03:53:00 INFO - PROCESS | 26335 | RSS: Main: 160591872 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | __start_tp_report 03:53:00 INFO - PROCESS | 26335 | _x_x_mozilla_page_load 03:53:00 INFO - PROCESS | 26335 | _x_x_mozilla_page_load_details 03:53:00 INFO - PROCESS | 26335 | |i|pagename|runs| 03:53:00 INFO - PROCESS | 26335 | |0;ai-astar;111;105;111;110;111;110;111;109;110;111 03:53:00 INFO - PROCESS | 26335 | |1;audio-beat-detection;150;133;157;189;124;155;153;128;179;136 03:53:00 INFO - PROCESS | 26335 | |2;audio-dft;162;163;163;160;161;162;164;162;160;166 03:53:00 INFO - PROCESS | 26335 | |3;audio-fft;76;76;75;183;76;75;76;89;164;76 03:53:00 INFO - PROCESS | 26335 | |4;audio-oscillator;85;85;156;85;85;85;131;86;85;144 03:53:00 INFO - PROCESS | 26335 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;118;119;118 03:53:00 INFO - PROCESS | 26335 | |6;imaging-darkroom;149;147;147;147;148;147;146;147;148;147 03:53:00 INFO - PROCESS | 26335 | |7;imaging-desaturate;96;96;97;96;95;96;95;95;96;95 03:53:00 INFO - PROCESS | 26335 | |8;json-parse-financial;53;55;55;54;57;55;52;55;54;57 03:53:00 INFO - PROCESS | 26335 | |9;json-stringify-tinderbox;61;60;59;60;60;61;61;59;60;59 03:53:00 INFO - PROCESS | 26335 | |10;stanford-crypto-aes;81;78;76;76;76;85;75;83;102;83 03:53:00 INFO - PROCESS | 26335 | |11;stanford-crypto-ccm;130;127;131;121;124;120;129;118;134;125 03:53:00 INFO - PROCESS | 26335 | |12;stanford-crypto-pbkdf2;158;155;162;156;153;162;154;153;154;156 03:53:00 INFO - PROCESS | 26335 | |13;stanford-crypto-sha256-iterative;65;63;63;66;67;62;61;61;61;62 03:53:00 INFO - PROCESS | 26335 | __end_tp_report 03:53:00 INFO - PROCESS | 26335 | __start_cc_report 03:53:00 INFO - PROCESS | 26335 | _x_x_mozilla_cycle_collect,868 03:53:00 INFO - PROCESS | 26335 | __end_cc_report 03:53:00 INFO - PROCESS | 26335 | __startTimestamp1467975180145__endTimestamp 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | ------- Summary: start ------- 03:53:00 INFO - PROCESS | 26335 | Number of tests: 14 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.85 (1.7%) stddev-sans-first:1.92 03:53:00 INFO - PROCESS | 26335 | Values: 111.0 105.0 111.0 110.0 111.0 110.0 111.0 109.0 110.0 111.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:21.31 (13.8%) stddev-sans-first:22.61 03:53:00 INFO - PROCESS | 26335 | Values: 150.0 133.0 157.0 189.0 124.0 155.0 153.0 128.0 179.0 136.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.83 (1.1%) stddev-sans-first:1.94 03:53:00 INFO - PROCESS | 26335 | Values: 162.0 163.0 163.0 160.0 161.0 162.0 164.0 162.0 160.0 166.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#3] audio-fft Cycles:10 Average:96.60 Median:76.00 stddev:40.99 (53.9%) stddev-sans-first:42.79 03:53:00 INFO - PROCESS | 26335 | Values: 76.0 76.0 75.0 183.0 76.0 75.0 76.0 89.0 164.0 76.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.88 (34.0%) stddev-sans-first:29.91 03:53:00 INFO - PROCESS | 26335 | Values: 85.0 85.0 156.0 85.0 85.0 85.0 131.0 86.0 85.0 144.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:53:00 INFO - PROCESS | 26335 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 03:53:00 INFO - PROCESS | 26335 | Values: 149.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 148.0 147.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:53:00 INFO - PROCESS | 26335 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.57 (2.8%) stddev-sans-first:1.54 03:53:00 INFO - PROCESS | 26335 | Values: 53.0 55.0 55.0 54.0 57.0 55.0 52.0 55.0 54.0 57.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 03:53:00 INFO - PROCESS | 26335 | Values: 61.0 60.0 59.0 60.0 60.0 61.0 61.0 59.0 60.0 59.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:79.50 stddev:8.05 (10.1%) stddev-sans-first:8.53 03:53:00 INFO - PROCESS | 26335 | Values: 81.0 78.0 76.0 76.0 76.0 85.0 75.0 83.0 102.0 83.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.00 stddev:5.22 (4.1%) stddev-sans-first:5.32 03:53:00 INFO - PROCESS | 26335 | Values: 130.0 127.0 131.0 121.0 124.0 120.0 129.0 118.0 134.0 125.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.00 stddev:3.37 (2.2%) stddev-sans-first:3.52 03:53:00 INFO - PROCESS | 26335 | Values: 158.0 155.0 162.0 156.0 153.0 162.0 154.0 153.0 154.0 156.0 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - PROCESS | 26335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.18 (3.5%) stddev-sans-first:2.20 03:53:00 INFO - PROCESS | 26335 | Values: 65.0 63.0 63.0 66.0 67.0 62.0 61.0 61.0 61.0 62.0 03:53:00 INFO - PROCESS | 26335 | -------- Summary: end -------- 03:53:00 INFO - PROCESS | 26335 | 03:53:00 INFO - TEST-INFO | 26335: exit 0 03:53:01 INFO - TEST-OK | kraken | took 60332ms 03:53:01 INFO - SUITE-END | took 1169s 03:53:01 INFO - Completed test suite (00:19:29) 03:53:01 INFO - javascript benchmark 03:53:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7566.136757429408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.820489873057, 3340.0313908966396, 3350.865965361386, 3369.090345606685, 3374.342003309354, 5555.112219451372, 5601.29983752031, 5606.55147588193, 5622.297212848394, 5632.831015069544, 5592.412796656344, 5639.238702775124, 5657.9434205658035, 5667.943320566793, 5678.205051292823, 5054.949450505503, 5137.101007323722, 5168.457311982244, 5183.688978661274, 5185.844424667266, 5043.470435604246, 5069.214271787879, 5209.1404918188455, 5217.3217481727515, 5243.632945693803, 5107.336046313974, 5109.514596113363, 5116.846494605168, 5158.48415158483, 5172.482751724835, 5099.872503187431, 5205.947940520584, 5206.973965130188, 5207.687538747668, 5238.554722848562, 4895.069936712013, 5043.9747801260755, 5112.872178195537, 5158.277841102249, 5181.145111056671, 5408.242846001563, 5475.151351540518, 5478.91781623276, 5545.417731138213, 5573.41479144692, 6000.099985002241, 6036.667983260919, 6042.607230530046, 6044.879102417971, 6057.394260573951, 5886.529077673776, 5962.850928726773, 6101.816945491642, 6105.786297479612, 6110.08348747687, 5524.8342549723575, 5656.1798539211995, 5686.829395118153, 5688.488036076732, 5710.200571919934, 6197.163382943335, 6216.191895053614, 6225.906611400833, 6229.159063526366, 6231.065340199007, 5746.080627099644, 5841.88316233673, 5865.266841644794, 5943.435373639497, 5959.910601340984, 6017.157597936292, 6030.095485677183, 6035.245594300713, 6045.21412216409, 6092.147099406086, 5972.0, 5985.191999080155, 6006.909896351558, 6015.3383127855905, 6035.064564992434, 5742.712864356766, 5922.496587790086, 5936.347001829795, 5992.43071908168, 6008.0, 4673.906521869543, 4675.22858728306, 4680.695754775928, 4686.882827929329, 4697.929531057037, 4185.476815398075, 4194.077302993336, 4197.370394440858, 4209.873703788891, 4241.491021077491, 5403.702796346239, 5682.516986056232, 5697.4587414195585, 5741.598088133791, 5787.88424231513, 5908.822735317947, 5914.645121292736, 6004.189434426384, 6030.216071910623, 6031.185789918305, 5579.107342825209, 5739.913901291484, 5741.827745167651, 5743.339515955635, 5761.279840019997, 5094.898102038012, 5096.184610462308, 5128.589712822965, 5155.458676838878, 5164.8192313268855, 6084.6349219047, 6104.4505994460715, 6138.631682098999, 6144.41628045335, 6146.385361463907, 5810.6513609183585, 5899.439553242435, 5989.520838332923, 6013.759449621966, 6015.157877897185, 6044.032954727222, 6120.90429240112, 6121.767558219948, 6125.572745538934, 6130.948521379913, 5885.529157667462, 5887.911681324698, 5888.087346461305, 5907.734151963258, 5914.994450943436, 5768.105943578752, 5951.285845698544, 5967.880642387041, 5982.850428739316, 6002.129691194839, 5857.648541087548, 5898.764049437975, 5948.524118070631, 5956.821295361146, 5978.581499295182, 5861.413858614104, 5901.940980590139, 5917.053271476543, 5918.319393269657, 5926.851828704144, 5584.553235741212, 5697.487226149667, 5709.65742055478, 5753.280839895013, 5767.596268261349, 5861.267341582302, 5894.528437724886, 5913.29040515141, 5930.970345148419, 5949.3753155918, 5759.827205183851, 5803.0, 5812.593118481835, 5813.505852002458, 5817.970910145592], "value": 5543.439246409238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9124131380293, 638.5434414393709, 639.6833567384145, 658.052404537466, 662.3409707341193, 34688.653113468856, 46263.53736462635, 47777.28334074992, 47865.0, 47886.52113478864, 49929.0, 50586.49413505864, 50603.0, 50612.49387506124, 50714.746426267906, 9010.053944335832, 9115.361924665276, 9116.8632470513, 9122.179003889649, 9173.54132293386, 8821.735347939572, 8931.642734290654, 8935.508547029911, 8959.0, 8968.237699795525, 9041.502717350542, 9045.457272563634, 9057.320700947423, 9095.909040909606, 9105.499197544132, 8923.821523569524, 9001.909980900173, 9023.18791308782, 9039.322050846213, 9048.683296084606, 8938.64245430182, 9009.864852027225, 9010.098990101003, 9012.549372531346, 9017.458952462874, 46629.533704662856, 46877.765611172064, 47045.05909881783, 47095.0, 47096.76451617754, 3786.772793632391, 3863.806809659534, 3867.1878905429894, 3881.844726210948, 3932.7247092703524, 34892.47661285083, 35171.4724279136, 35237.0, 35288.11779705502, 35352.46971295433, 4603.309503574457, 4761.738104404257, 4817.301491283779, 4885.169521181372, 4917.975410122962, 375777.0, 379950.0, 382943.0, 383251.0, 384948.0, 38899.61100389017, 65282.36794080091, 65743.34256657468, 65930.34069659338, 66042.66978665076, 39663.80168099141, 40580.59419405827, 40673.18653626911, 40981.590184097775, 41023.794881026, 16574.337026518806, 16696.081715505763, 16769.580760481087, 16775.0, 16789.91605041967, 14807.777883331759, 14823.851761482463, 14826.62933426673, 14980.475683351031, 14988.47540336083, 9109.77225569366, 9195.402298850553, 9205.953970230106, 9219.861702074475, 9244.491552964517, 3484.181217413906, 3485.634008429078, 3503.597086335053, 3508.8947331580093, 3561.4479755637917, 1114.637742733615, 1162.9883701163048, 1178.4107946026986, 1180.7520420711746, 1214.5566868093083, 34894.12764680853, 35128.47307290393, 37053.07367315785, 37392.62607373892, 38030.809845951146, 1213.205350495427, 1222.743223922986, 1223.3027174510444, 1228.8709685482895, 1248.4257241668934, 17627.0, 17735.46793596194, 17790.644187116184, 17843.286268549113, 18010.459686209433, 567132.0, 573534.0, 576170.0, 581290.0, 668415.0, 64637.35362646407, 64977.675111624136, 65241.673791631685, 65293.0, 65522.672386637765, 1474.5944865162166, 1502.774583812415, 1507.0882116319688, 1507.4422463688286, 1530.8851836112335, 33820.3235935275, 33978.0, 34137.82931085329, 34425.65574344325, 34759.652403476655, 56427.71786141043, 57142.7142864283, 57370.0, 57586.42413575978, 57664.0, 542523.0, 557260.0, 557434.0, 559617.0, 559872.0, 31742.36515269728, 32101.0, 32147.839260803546, 32156.356872862878, 32190.83904580462, 52016.21975670292, 52656.47343526669, 52727.73636131795, 53077.0, 53155.73422132865, 42807.35788963106, 43867.341989869536, 44075.0, 44457.33314000228, 44957.775211123735, 43041.569584305005, 43899.12201756011, 44348.0, 44935.0, 45008.77495612501, 43131.353029703954, 44243.778781107176, 44709.32936006028, 44864.0, 45132.77433612811, 38317.0, 38371.6162838368, 38487.79049722436, 38698.80650596729, 39322.0, 29720.554191686708, 29837.0, 29962.25094372658, 30021.24946876258, 30390.088297351114], "value": 20599.979238798758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.46639368820536, 420.87373787863635, 423.57430782064023, 423.758457679123, 432.9242382583049, 18865.622687546256, 19650.7052394214, 20481.07835147418, 21094.472638184016, 21109.788902110973, 18365.44903652889, 19272.22911083555, 19397.224111035543, 19618.607627847436, 20202.0, 5195.688258704471, 5331.946680533184, 5346.064438723227, 5346.625736198448, 5347.652402593819, 5279.947200528003, 5495.313085864267, 5801.187833703285, 5822.301323841145, 5863.208466856983, 5621.437856214387, 5834.679092649923, 5871.324797648261, 6024.066269728177, 6026.306974697922, 5927.2887253529425, 5958.97020514899, 6007.339192688801, 6013.398660133996, 6028.5478589106, 5754.338251101135, 5797.768089276424, 5898.941010589882, 5943.3462319144855, 5986.820395388146, 20195.788252704737, 23331.766682333127, 24149.275521734377, 24234.87882560576, 24295.878520607283, 2440.2801173653816, 2491.302435318114, 2506.4611108611552, 2510.3096648421647, 2703.4187649655223, 10808.675739727822, 10874.565017399294, 10889.074428673572, 12744.490220391173, 15370.693491053275, 2042.5812708394744, 2069.4205622425743, 2104.970095901928, 2126.5853158634072, 2151.601953638582, 81037.18962810414, 82346.58826705888, 84085.15914840835, 85139.5743021281, 85768.0, 11592.942035289769, 11612.535498580131, 11830.112741544419, 11918.880811191777, 11926.940365298291, 14619.707605848036, 16706.0, 16747.748783768253, 16846.073465959245, 16912.57718557021, 8333.874991875127, 8738.825223495494, 8889.066648001995, 9131.086891310815, 9228.215601673934, 8986.505742184112, 9037.322200834964, 9055.320850936207, 9056.275497960147, 9209.539523023823, 4939.975300123549, 5085.74571271435, 5103.515166059218, 5162.45794191612, 5162.767675454614, 2063.123172651617, 2105.3999610111046, 2122.4163355077476, 2123.830093592509, 2138.582976319634, 1004.5730564510054, 1100.6477927063422, 1102.3385968419045, 1107.9723006924892, 1142.8342890281028, 17681.557961051076, 19070.0, 19894.403167904988, 19896.403107906786, 20230.0, 1073.9677809665723, 1087.3312912558877, 1090.6346373964811, 1118.8825173356843, 1141.4064686363045, 10988.0, 11038.7857335693, 11063.336199828036, 11230.66308010761, 11263.380514071805, 541012.0, 544575.0, 556649.0, 558742.0, 560408.0, 52250.47749522532, 74533.627331863, 100539.0, 101459.49270253601, 101703.0, 1092.5247517329988, 1094.3488624268548, 1102.9742339624227, 1106.6679996001328, 1118.5637601335486, 17446.825531745028, 17562.473125806246, 17933.219764883757, 18084.0, 18133.093345332418, 33161.336773263916, 41026.17947640971, 41423.0, 42458.57541424546, 43692.34461483017, 57729.422705774086, 59019.704901476936, 59446.70276648589, 60085.0, 60201.0, 9022.413543119676, 9074.0, 9133.634654613741, 9136.862947055666, 9325.766855828659, 9892.604295828374, 14154.0, 14256.786148207577, 14359.856401435853, 14370.281485925452, 12223.69440763988, 12469.127161098637, 12473.251604903735, 12561.685957851127, 12722.236665800081, 6828.760993365408, 11194.0, 12198.390080495763, 12301.815472768094, 12559.0, 12040.21738586989, 12606.0, 12662.746745065231, 12842.229466232056, 12923.22460652364, 9088.136627020422, 9171.908280917105, 9193.942696589978, 9267.165955064076, 9304.95347523285, 10800.94492104936, 11892.0, 12060.939695301468, 12201.389930503261, 12249.713780052965], "value": 9661.741877426282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1558.2831897327228, 1583.1451016451115, 1816.26441291277, 1893.5550145715754, 1910.0640686063832, 8380.497170169794, 9232.353735238528, 9312.906870931289, 10049.04534069264, 10052.748681282972, 9366.531673416335, 9694.56374463149, 9773.706788796348, 9781.7554561136, 9810.705678829629, 2409.6987876515436, 2416.069813121952, 2445.119756887519, 2449.6570480132796, 2455.484348286862, 2391.8804059797026, 2422.2612103308484, 2423.866687332196, 2424.2969538833718, 2430.6232533957264, 2338.3218866528687, 2366.25462979161, 2369.3839601703507, 2379.9171377023413, 2383.535210633927, 2216.822654187661, 2237.7762223777654, 2238.5858616156065, 2244.2481768607454, 2295.758945310735, 2283.246528645543, 2323.59337116004, 2324.37241944674, 2328.2316835444262, 2328.685627440291, 9718.31971761977, 9796.804063918753, 9822.508874556315, 9832.0, 9832.803343933081, 5606.607537472379, 5752.395998420147, 5758.596898217126, 5769.624974376652, 5787.797427090031, 3556.0, 3565.144365352297, 3650.3246899323444, 3661.2677464506937, 3673.687736542397, 1194.7252132009598, 1196.347990345264, 1216.6106845809345, 1231.9568815091518, 1240.6774238697913, 13858.584242472742, 13912.791308130387, 13926.791098133535, 14043.929780351033, 14100.08349457282, 4751.287306903992, 4840.661153719206, 4891.095147397743, 4904.60763138948, 4928.310036594879, 10678.73303167427, 10759.623413180501, 10852.294600850919, 10877.184211184192, 10920.890791092146, 5622.887542249132, 5654.9151762723595, 5680.687562184037, 5703.828885133453, 5706.828795136153, 4576.290674945389, 5086.821961231339, 5212.139996900469, 5219.451957544403, 5230.320058392461, 4054.6958978076173, 4110.203096444995, 4143.316352801754, 4192.266353388145, 4207.0954744729415, 1203.3501908969058, 1232.5932442294022, 1234.6789834643057, 1245.1470742541387, 1250.93745312734, 959.9520023998912, 985.6648739428485, 1048.2766890845292, 1055.7044027672264, 1059.046857827961, 6393.041043843367, 6445.258795238514, 6508.739650414025, 6604.570702904296, 6619.338066193439, 455.769836232707, 466.6080492386412, 470.82814772608435, 474.6250462134944, 486.093435742338, 4600.171969045604, 4600.401947746838, 4606.124836281096, 4616.930746038812, 4630.4443466784205, 11507.539698411969, 12182.0, 12617.432215550321, 12623.684407889876, 12637.873621263854, 11788.351640659846, 12074.517019319304, 12139.0, 12356.38218089092, 12365.443555040045, 8903.510306933182, 8952.68665596701, 8977.416467929565, 9022.819543609092, 9076.455412675261, 6522.673866306571, 6644.468442524683, 6718.630475323904, 6838.726450942106, 6908.067410899665, 11096.944515277371, 11161.553537858395, 11221.102311815199, 11346.638403391316, 11568.132390070947, 11544.307341559534, 11680.0, 11705.707357315794, 11708.88291117112, 11759.353235572125, 8717.564121794012, 8736.56317184151, 8772.868406973774, 8893.199612034949, 8896.065913079034, 9308.208802251884, 9371.109744574254, 9395.577199025924, 9429.0, 9516.524173791422, 8701.869471958053, 8703.608337624948, 8741.213290803604, 8752.387332886638, 8760.956195219238, 8382.874256886274, 8423.284020858297, 8466.111058339033, 8468.872966905625, 8596.957015214884, 7762.650680719494, 7827.6868925244635, 7888.605569721606, 7899.68401263966, 7932.405069619917, 5673.943260567342, 5675.744591493475, 5772.682502462405, 5774.538036956949, 5776.0, 5520.171974203901, 5634.352049514195, 5653.858653533694, 5655.773769049192, 5751.1373294006235], "value": 4922.9921035939215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.6451397005204, 345.8720273498805, 347.63498326756905, 349.7806418276041, 354.34976817539814, 5569.777208911649, 5672.858178545538, 5674.858128546778, 5684.602077854552, 5703.173039909216, 5584.497395234428, 5598.440155984399, 5601.915971260434, 5622.578306627009, 5630.1554766785, 4373.497047839507, 4390.956090439095, 4397.868063958071, 4400.537943515933, 4403.691741578091, 4247.897290841038, 4343.9348409773875, 4375.234333991555, 4390.187815254172, 4440.933385999197, 4268.957310426903, 4294.0, 4315.805788739514, 4322.82708691652, 4333.371661109138, 4296.248156572603, 4350.564943505624, 4353.10761293934, 4394.78026098697, 4407.559244075599, 3709.5919448860604, 3845.7115716321387, 3860.8455661773496, 3862.7102967277287, 3865.7487263328076, 5338.599605029638, 5363.731813409314, 5380.21986811914, 5387.164989426645, 5422.2951016368015, 4914.336564563774, 4928.472173626152, 4980.327655766498, 4984.0, 4998.975005124988, 5664.422687677097, 5816.0, 5872.0, 5879.029960056586, 5921.348651648315, 4169.687273454503, 4179.582041795827, 4197.748135111872, 4198.265303571863, 4209.6000879916355, 6084.0, 6091.908621370683, 6108.511319094462, 6127.6017058891475, 6163.1679723237685, 4023.4970628671417, 4288.399624052635, 4325.264705000158, 4328.848490302824, 4347.06538094305, 4316.093620339764, 4328.675349348811, 4344.47866256045, 4354.6951713380395, 4407.669424793154, 4946.752662366867, 4981.501849814989, 4986.850394488171, 5007.39911210657, 5036.445990940993, 5597.216389705444, 5903.9668058089665, 5914.556408269397, 5920.970395147997, 5921.2302400688495, 1476.5201309574215, 1490.3219035338896, 1498.655309278872, 1498.8576085271882, 1502.143778046503, 939.8073394954018, 947.545178314413, 955.8948515663271, 961.9422834629804, 976.5068640336584, 5076.466970968069, 5080.441151473335, 5105.7191854448365, 5118.87202819925, 5124.027249508966, 5425.0, 5442.6462279951675, 5460.972695136578, 5479.479449452296, 5516.282883225155, 5013.573846223112, 5062.557171206188, 5105.310783044241, 5149.407818100966, 5217.530422262014, 2831.631887854566, 2865.957010644842, 2875.6549214094443, 2882.610847535556, 2889.8699558519916, 5407.0, 5448.101063324507, 5513.558915286768, 5558.471945165203, 5579.9163012554845, 5190.844274671766, 5430.91853622196, 5453.182022696627, 5454.3454785426, 5472.425395333512, 5417.160340147283, 5455.699936503531, 5460.726963651881, 5471.534919531884, 5572.972135139298, 4997.475265097258, 5355.892882142413, 5356.767943372968, 5395.2176934343515, 5408.837734867803, 5244.898571300069, 5276.577873770166, 5295.629305948547, 5302.787888484418, 5305.9204111939125, 5411.538884501084, 5430.755615997211, 5438.782448702008, 5462.289902312674, 5865.824025279248, 4116.91766164669, 4248.34150706641, 4258.276093064249, 4263.914721705486, 4280.571942805695, 5927.881442371042, 5971.731272092679, 5974.37269086757, 6001.639901605918, 6005.849853753691, 5641.492265696107, 5794.652320860761, 5818.505427038749, 5828.484594005505, 5833.979053665506, 5720.713964301685, 5729.570282228933, 5771.682557459212, 5787.119186264396, 5809.157672137601, 5717.656940583578, 5732.627379220337, 5737.827865164052, 5744.0, 5810.215620891126, 5629.54963602919, 5831.862786756542, 5869.6771677558145, 5881.647101173943, 5888.528917686489, 5679.77280908759, 5718.428157184248, 5727.885442291047, 5779.335376431764, 5791.218185544897], "value": 4323.963884607721, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.9191588925218, 749.955002699838, 766.0462723908735, 797.3621103117506, 883.434601854813, 15561.533154005383, 15715.921420392911, 15745.84254157458, 15799.605009874731, 16102.597435064115, 15397.384104635828, 15556.45552405666, 15683.84316156838, 15697.607559811011, 15701.214939253021, 724.5000949344949, 829.1211316005054, 848.6435697007241, 849.9192576705203, 854.2909385210291, 866.3891956170916, 867.9132086791302, 870.83889480446, 871.8866547348836, 872.8123453457505, 908.5321059654283, 911.0752586125088, 912.1425859691868, 916.8533034714447, 917.2845180758985, 907.0702529906832, 908.3686837647838, 910.7540963939732, 911.5168960450972, 912.3567884641345, 667.6995352091578, 669.7655820462799, 670.4133882852504, 671.3990978074596, 671.8992151177314, 15129.621759455991, 15136.470223542234, 15252.923735381251, 15265.160416177107, 15306.540803775904, 15970.829716976436, 16633.0, 16639.25123369451, 16644.33422663092, 16657.91671041649, 12337.561765249591, 12374.75250494994, 12424.627261182179, 12600.243985360908, 12699.0, 4103.671706263492, 4126.216018956388, 4156.981539522836, 4290.549492303295, 4307.246231909403, 69733.30266697319, 79416.60291698505, 80162.19837801605, 81143.18856811474, 82033.17966820316, 12108.515659373703, 12546.372681365896, 12589.181703189446, 12603.621891343275, 12828.29444380568, 22401.551968960528, 22420.215292464687, 22424.766637835077, 22467.775322246896, 22510.774892251196, 9240.768980775534, 9379.108984646447, 9444.8583271251, 9809.754756131153, 9845.163161131384, 5208.9739551302755, 5221.973890130525, 5239.947600524022, 5313.654612450178, 5323.0, 3835.5972622874756, 3966.484357033567, 3971.285168669667, 4008.0581063450068, 4141.109661422808, 754.9584772837437, 773.2576726342774, 782.335015237044, 784.3920961254959, 787.79123532264, 685.533836990841, 742.2911119880501, 770.4799260499141, 785.615048626169, 797.4975765267844, 10287.22845786554, 10720.946395267974, 10842.241043126905, 10932.617358392417, 11034.613788517523, 735.577043200162, 745.0388998192379, 787.3425689549176, 803.5901690138072, 815.995920020396, 4962.230854217602, 5000.449950505442, 5069.898602027939, 5085.771140298695, 5163.586913046947, 120561.0, 124404.0, 126025.0, 127338.0, 127434.0, 106502.46748766207, 108011.45994269979, 110455.0, 110625.0, 115043.42478287722, 80733.0, 88281.0, 90388.5480572606, 91093.0, 93172.53413732888, 9650.179734722627, 9835.901640983499, 9948.850767238642, 10001.5499302533, 10031.648892288735, 38779.61220387873, 41721.58278417177, 55606.16590751061, 56008.15987760268, 56043.439565603825, 68851.65574172097, 69813.65093174501, 71135.28864711287, 76366.61816690881, 82086.17913821024, 13337.466501340226, 13343.733125337632, 13520.661983450493, 13530.0, 14380.640483987983, 14355.138691678532, 14555.345009474811, 14654.194019328614, 14669.779953300496, 14827.92586037063, 13002.219866808022, 13402.798958015832, 13735.862641373858, 14210.644733881736, 14545.563633091024, 12939.870601293867, 12979.221246725227, 12982.80525792095, 13020.674483137997, 13402.93298533501, 13052.477900883858, 13263.137896036727, 13589.932050339685, 13670.11144275619, 13840.93079534596, 10704.571817127538, 10764.246502744732, 10872.238943274211, 10922.126229901747, 10943.45282735876, 11364.279859920887, 11372.60195893173, 11921.165518413974, 11966.0, 12125.454354553889], "value": 7987.1055039878, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 157.0, 189.0, 124.0, 155.0, 153.0, 128.0, 179.0, 136.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 160.0, 161.0, 162.0, 164.0, 162.0, 160.0, 166.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 183.0, 76.0, 75.0, 76.0, 89.0, 164.0, 76.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 156.0, 85.0, 85.0, 85.0, 131.0, 86.0, 85.0, 144.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 57.0, 55.0, 52.0, 55.0, 54.0, 57.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 61.0, 59.0, 60.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 76.0, 76.0, 76.0, 85.0, 75.0, 83.0, 102.0, 83.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 131.0, 121.0, 124.0, 120.0, 129.0, 118.0, 134.0, 125.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 162.0, 156.0, 153.0, 162.0, 154.0, 153.0, 154.0, 156.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 66.0, 67.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 63.1, "unit": "score"}]}]} 03:53:01 INFO - Return code: 0 03:53:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:01 ERROR - # TBPL SUCCESS # 03:53:01 INFO - Running post-action listener: _resource_record_post_action 03:53:01 INFO - ##### 03:53:01 INFO - ##### Finished run-tests step (success) 03:53:01 INFO - ##### 03:53:01 INFO - Running post-run listener: _resource_record_post_run 03:53:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 290816; Write bytes: 508919808; Read time: 32; Write time: 333256 03:53:01 INFO - TinderboxPrint: CPU usage
13.4% 03:53:01 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 32 03:53:01 INFO - TinderboxPrint: I/O write bytes / time
508,919,808 / 333,256 03:53:01 INFO - TinderboxPrint: CPU idle
8,198.1 (86.6%) 03:53:01 INFO - TinderboxPrint: CPU user
1,218.3 (12.9%) 03:53:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 258633728; Read time: 0; Write time: 199744 03:53:01 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249606144; Read time: 16; Write time: 133512 03:53:02 INFO - Running post-run listener: _upload_blobber_files 03:53:02 INFO - Blob upload gear active. 03:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:03 INFO - (blobuploader) - INFO - Done attempting. 03:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:06 INFO - (blobuploader) - INFO - Done attempting. 03:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:07 INFO - (blobuploader) - INFO - Done attempting. 03:53:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:07 INFO - Return code: 0 03:53:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e23470ea6bd5abb384a88ddeed5c76c87ffdd977211c609918ed4352e6e8ecd617e5ac4db4e09b1808e1324f95b355d1eb345f102bee821cf030c0c25a9c27f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e673c265bd5f97d4292fae2123287a95a4bda13f9c26085cfc5c4c8e694e813b64668383f6408d212e0f742e42fd698be46634d7da1efcaa11e88646e2f6590f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4374e61ecb4b8939a1c844dddf3f657e9aa175937bc8ec3132b0371e531049b05ae34eb841b2f1f6b45273ebe8d7b95083d5bb0bd3959d420836f2fc834485ca"} 03:53:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:07 INFO - Contents: 03:53:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e23470ea6bd5abb384a88ddeed5c76c87ffdd977211c609918ed4352e6e8ecd617e5ac4db4e09b1808e1324f95b355d1eb345f102bee821cf030c0c25a9c27f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e673c265bd5f97d4292fae2123287a95a4bda13f9c26085cfc5c4c8e694e813b64668383f6408d212e0f742e42fd698be46634d7da1efcaa11e88646e2f6590f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4374e61ecb4b8939a1c844dddf3f657e9aa175937bc8ec3132b0371e531049b05ae34eb841b2f1f6b45273ebe8d7b95083d5bb0bd3959d420836f2fc834485ca"} 03:53:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:07 INFO - Copying logs to upload dir... 03:53:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.470631 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-08 03:53:06.259148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:53:06.262440) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e23470ea6bd5abb384a88ddeed5c76c87ffdd977211c609918ed4352e6e8ecd617e5ac4db4e09b1808e1324f95b355d1eb345f102bee821cf030c0c25a9c27f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e673c265bd5f97d4292fae2123287a95a4bda13f9c26085cfc5c4c8e694e813b64668383f6408d212e0f742e42fd698be46634d7da1efcaa11e88646e2f6590f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4374e61ecb4b8939a1c844dddf3f657e9aa175937bc8ec3132b0371e531049b05ae34eb841b2f1f6b45273ebe8d7b95083d5bb0bd3959d420836f2fc834485ca"} build_url:https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/Zy6leXWWRmKLPgJ-ULPD0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e23470ea6bd5abb384a88ddeed5c76c87ffdd977211c609918ed4352e6e8ecd617e5ac4db4e09b1808e1324f95b355d1eb345f102bee821cf030c0c25a9c27f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e673c265bd5f97d4292fae2123287a95a4bda13f9c26085cfc5c4c8e694e813b64668383f6408d212e0f742e42fd698be46634d7da1efcaa11e88646e2f6590f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4374e61ecb4b8939a1c844dddf3f657e9aa175937bc8ec3132b0371e531049b05ae34eb841b2f1f6b45273ebe8d7b95083d5bb0bd3959d420836f2fc834485ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:53:06.287646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:53:06.287960) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467973957.544876-450777356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:53:06.369688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:53:06.369993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:53:06.370275) ========= ========= Total master_lag: 0.15 =========