builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1468189080.66 results: success (0) buildid: 20160710123925 builduid: 5f52a2cea9ff42e088cadfe1edf07ff2 revision: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.661629) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.662074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.662363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.734280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.734598) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 15:18:00-- 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% 70.6M=0s 2016-07-10 15:18:01 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.254339 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.016480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.016816) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049709 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.078889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.079210) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf --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 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf --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=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 15:18:01,133 truncating revision to first 12 chars 2016-07-10 15:18:01,134 Setting DEBUG logging. 2016-07-10 15:18:01,134 attempt 1/10 2016-07-10 15:18:01,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f0d18b6adc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-10 15:18:01,578 unpacking tar archive at: mozilla-aurora-9f0d18b6adc5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.846877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.847166) ========= script_repo_revision: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.847574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.847862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.869656) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-10 15:18:01.869972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:02 INFO - MultiFileLogger online at 20160710 15:18:02 in /builds/slave/test 15:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:02 INFO - {'append_to_log': False, 15:18:02 INFO - 'base_work_dir': '/builds/slave/test', 15:18:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:02 INFO - 'branch': 'Mozilla-Aurora', 15:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:02 INFO - 'config_files': ('talos/linux_config.py',), 15:18:02 INFO - 'default_actions': ('clobber', 15:18:02 INFO - 'read-buildbot-config', 15:18:02 INFO - 'download-and-extract', 15:18:02 INFO - 'populate-webroot', 15:18:02 INFO - 'create-virtualenv', 15:18:02 INFO - 'install', 15:18:02 INFO - 'run-tests'), 15:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:02 INFO - 'download_minidump_stackwalk': True, 15:18:02 INFO - 'download_symbols': 'ondemand', 15:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:02 INFO - 'installer_path': 'installer.exe', 15:18:02 INFO - 'log_level': 'info', 15:18:02 INFO - 'log_name': 'talos', 15:18:02 INFO - 'log_to_console': True, 15:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:02 INFO - 'opt_config_files': (), 15:18:02 INFO - 'pip_index': False, 15:18:02 INFO - 'sps_profile': False, 15:18:02 INFO - 'sps_profile_interval': 0, 15:18:02 INFO - 'suite': 'dromaeojs', 15:18:02 INFO - 'system_bits': '32', 15:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:02 INFO - 'title': 'talos-linux64-ix-047', 15:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:02 INFO - 'use_talos_json': True, 15:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:02 INFO - 'work_dir': 'build'} 15:18:02 INFO - ##### 15:18:02 INFO - ##### Running clobber step. 15:18:02 INFO - ##### 15:18:02 INFO - Running pre-action listener: _resource_record_pre_action 15:18:02 INFO - Running main action method: clobber 15:18:02 INFO - rmtree: /builds/slave/test/build 15:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:06 INFO - Running post-action listener: _resource_record_post_action 15:18:06 INFO - ##### 15:18:06 INFO - ##### Finished clobber step (success) 15:18:06 INFO - ##### 15:18:06 INFO - ##### 15:18:06 INFO - ##### Running read-buildbot-config step. 15:18:06 INFO - ##### 15:18:06 INFO - Running pre-action listener: _resource_record_pre_action 15:18:06 INFO - Running main action method: read_buildbot_config 15:18:06 INFO - Using buildbot properties: 15:18:06 INFO - { 15:18:06 INFO - "project": "", 15:18:06 INFO - "product": "firefox", 15:18:06 INFO - "script_repo_revision": "production", 15:18:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:18:06 INFO - "repository": "", 15:18:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:18:06 INFO - "buildid": "20160710123925", 15:18:06 INFO - "pgo_build": "True", 15:18:06 INFO - "basedir": "/builds/slave/test", 15:18:06 INFO - "buildnumber": 364, 15:18:06 INFO - "slavename": "talos-linux64-ix-047", 15:18:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:18:06 INFO - "platform": "ubuntu64_hw", 15:18:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:18:06 INFO - "branch": "mozilla-aurora", 15:18:06 INFO - "repo_path": "releases/mozilla-aurora", 15:18:06 INFO - "revision": "9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf", 15:18:06 INFO - "stage_platform": "linux64-pgo", 15:18:06 INFO - "builduid": "5f52a2cea9ff42e088cadfe1edf07ff2", 15:18:06 INFO - "slavebuilddir": "test" 15:18:06 INFO - } 15:18:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:18:06 INFO - Running post-action listener: _resource_record_post_action 15:18:06 INFO - ##### 15:18:06 INFO - ##### Finished read-buildbot-config step (success) 15:18:06 INFO - ##### 15:18:06 INFO - ##### 15:18:06 INFO - ##### Running download-and-extract step. 15:18:06 INFO - ##### 15:18:06 INFO - Running pre-action listener: _resource_record_pre_action 15:18:06 INFO - Running main action method: download_and_extract 15:18:06 INFO - mkdir: /builds/slave/test/build/tests 15:18: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')]} 15:18:06 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:07 INFO - Downloaded 1361 bytes. 15:18:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:07 INFO - Using the following test package requirements: 15:18:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:18:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'jsshell-linux-x86_64.zip'], 15:18:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:18:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:18:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:07 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')]} 15:18:07 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:09 INFO - Downloaded 24526720 bytes. 15:18:09 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'] 15:18:09 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 15:18:11 INFO - Return code: 0 15:18:11 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 15:18:11 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')]} 15:18:11 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:15 INFO - Downloaded 24526720 bytes. 15:18:15 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'] 15:18:15 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 15:18:17 INFO - Return code: 0 15:18:17 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')]} 15:18:17 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:18 INFO - Downloaded 10833369 bytes. 15:18:18 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'] 15:18:18 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 15:18:18 INFO - Return code: 0 15:18:18 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')]} 15:18:18 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:19 INFO - Downloaded 63644723 bytes. 15:18:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:19 INFO - mkdir: /builds/slave/test/properties 15:18:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:19 INFO - Contents: 15:18:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:20 INFO - Running post-action listener: _resource_record_post_action 15:18:20 INFO - Running post-action listener: set_extra_try_arguments 15:18:20 INFO - ##### 15:18:20 INFO - ##### Finished download-and-extract step (success) 15:18:20 INFO - ##### 15:18:20 INFO - ##### 15:18:20 INFO - ##### Running populate-webroot step. 15:18:20 INFO - ##### 15:18:20 INFO - Running pre-action listener: _resource_record_pre_action 15:18:20 INFO - Running main action method: populate_webroot 15:18:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:20 INFO - '--tppagecycles', 15:18:20 INFO - '7'], 15:18:20 INFO - 'tests': ['tsvgm']}}, 15:18:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['damp', 'tps']}, 15:18:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'tests': ['damp', 'tps']}, 15:18:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['dromaeo_dom']}, 15:18:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['a11yr', 15:18:20 INFO - 'ts_paint', 15:18:20 INFO - 'tpaint', 15:18:20 INFO - 'sessionrestore', 15:18:20 INFO - 'sessionrestore_no_auto_restore', 15:18:20 INFO - 'tabpaint']}, 15:18:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['tsvgx', 15:18:20 INFO - 'tsvgr_opacity', 15:18:20 INFO - 'tart', 15:18:20 INFO - 'tscrollx', 15:18:20 INFO - 'cart']}, 15:18:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:20 INFO - 'tsvgr_opacity', 15:18:20 INFO - 'tart', 15:18:20 INFO - 'tscrollx', 15:18:20 INFO - 'cart']}, 15:18:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'talos_options': ['--disable-e10s'], 15:18:20 INFO - 'tests': ['tp5o']}, 15:18:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'tests': ['tp5o']}, 15:18:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'talos_options': ['--disable-e10s', 15:18:20 INFO - '--xperf_path', 15:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:20 INFO - 'tests': ['tp5n']}, 15:18:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:20 INFO - 'talos_options': ['--xperf_path', 15:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:20 INFO - 'tests': ['tp5n']}}, 15:18:20 INFO - 'talos.zip': {'path': '', 15:18:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:20 INFO - Running post-action listener: _resource_record_post_action 15:18:20 INFO - ##### 15:18:20 INFO - ##### Finished populate-webroot step (success) 15:18:20 INFO - ##### 15:18:20 INFO - ##### 15:18:20 INFO - ##### Running create-virtualenv step. 15:18:20 INFO - ##### 15:18:20 INFO - Running pre-action listener: _resource_record_pre_action 15:18:20 INFO - Running main action method: create_virtualenv 15:18:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:20 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 15:18:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:20 INFO - Using real prefix '/usr' 15:18:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:23 INFO - Installing pip.................done. 15:18:23 INFO - Return code: 0 15:18:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:23 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:23 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 15:18:23 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 15:18:23 INFO - Using env: {'DISPLAY': ':0', 15:18:23 INFO - 'HOME': '/home/cltbld', 15:18:23 INFO - 'LANG': 'en_US.UTF-8', 15:18:23 INFO - 'LANGUAGE': 'en_US:en', 15:18:23 INFO - 'LOGNAME': 'cltbld', 15:18:23 INFO - 'MAIL': '/var/mail/cltbld', 15:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:23 INFO - 'MOZ_NO_REMOTE': '1', 15:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:23 INFO - 'NO_EM_RESTART': '1', 15:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:23 INFO - 'PWD': '/builds/slave/test', 15:18:23 INFO - 'SHELL': '/bin/bash', 15:18:23 INFO - 'SHLVL': '1', 15:18:23 INFO - 'TERM': 'linux', 15:18:23 INFO - 'TMOUT': '86400', 15:18:23 INFO - 'USER': 'cltbld', 15:18:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:23 INFO - '_': '/tools/buildbot/bin/python'} 15:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:23 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 15:18:23 INFO - Cleaning up... 15:18:23 INFO - Return code: 0 15:18:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:23 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:23 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 15:18:23 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 15:18:23 INFO - Using env: {'DISPLAY': ':0', 15:18:23 INFO - 'HOME': '/home/cltbld', 15:18:23 INFO - 'LANG': 'en_US.UTF-8', 15:18:23 INFO - 'LANGUAGE': 'en_US:en', 15:18:23 INFO - 'LOGNAME': 'cltbld', 15:18:23 INFO - 'MAIL': '/var/mail/cltbld', 15:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:23 INFO - 'MOZ_NO_REMOTE': '1', 15:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:23 INFO - 'NO_EM_RESTART': '1', 15:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:23 INFO - 'PWD': '/builds/slave/test', 15:18:23 INFO - 'SHELL': '/bin/bash', 15:18:23 INFO - 'SHLVL': '1', 15:18:23 INFO - 'TERM': 'linux', 15:18:23 INFO - 'TMOUT': '86400', 15:18:23 INFO - 'USER': 'cltbld', 15:18:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:23 INFO - '_': '/tools/buildbot/bin/python'} 15:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:23 INFO - Downloading/unpacking psutil>=3.1.1 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 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 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:26 INFO - Installing collected packages: psutil 15:18:26 INFO - Running setup.py install for psutil 15:18:26 INFO - building 'psutil._psutil_linux' extension 15:18:26 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 15:18:27 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 15:18:27 INFO - building 'psutil._psutil_posix' extension 15:18:27 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 15:18:27 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 15:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:27 INFO - Successfully installed psutil 15:18:27 INFO - Cleaning up... 15:18:27 INFO - Return code: 0 15:18:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:18:27 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')]} 15:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:27 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')]} 15:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:27 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:27 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 15:18:27 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 15:18:27 INFO - Using env: {'DISPLAY': ':0', 15:18:27 INFO - 'HOME': '/home/cltbld', 15:18:27 INFO - 'LANG': 'en_US.UTF-8', 15:18:27 INFO - 'LANGUAGE': 'en_US:en', 15:18:27 INFO - 'LOGNAME': 'cltbld', 15:18:27 INFO - 'MAIL': '/var/mail/cltbld', 15:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:27 INFO - 'MOZ_NO_REMOTE': '1', 15:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:27 INFO - 'NO_EM_RESTART': '1', 15:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:27 INFO - 'PWD': '/builds/slave/test', 15:18:27 INFO - 'SHELL': '/bin/bash', 15:18:27 INFO - 'SHLVL': '1', 15:18:27 INFO - 'TERM': 'linux', 15:18:27 INFO - 'TMOUT': '86400', 15:18:27 INFO - 'USER': 'cltbld', 15:18:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:27 INFO - '_': '/tools/buildbot/bin/python'} 15:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:18:27 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 15:18:27 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 15:18:27 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 15:18:27 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 15:18:27 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 15:18:27 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 15:18:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:18:29 INFO - Installing collected packages: mozsystemmonitor 15:18:29 INFO - Running setup.py install for mozsystemmonitor 15:18:29 INFO - Successfully installed mozsystemmonitor 15:18:29 INFO - Cleaning up... 15:18:29 INFO - Return code: 0 15:18:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:29 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:29 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 15:18:29 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 15:18:29 INFO - Using env: {'DISPLAY': ':0', 15:18:29 INFO - 'HOME': '/home/cltbld', 15:18:29 INFO - 'LANG': 'en_US.UTF-8', 15:18:29 INFO - 'LANGUAGE': 'en_US:en', 15:18:29 INFO - 'LOGNAME': 'cltbld', 15:18:29 INFO - 'MAIL': '/var/mail/cltbld', 15:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:29 INFO - 'MOZ_NO_REMOTE': '1', 15:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:29 INFO - 'NO_EM_RESTART': '1', 15:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:29 INFO - 'PWD': '/builds/slave/test', 15:18:29 INFO - 'SHELL': '/bin/bash', 15:18:29 INFO - 'SHLVL': '1', 15:18:29 INFO - 'TERM': 'linux', 15:18:29 INFO - 'TMOUT': '86400', 15:18:29 INFO - 'USER': 'cltbld', 15:18:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:29 INFO - '_': '/tools/buildbot/bin/python'} 15:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:29 INFO - Downloading/unpacking jsonschema==2.5.1 15:18:29 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 15:18:29 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 15:18:29 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 15:18:29 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 15:18:29 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 15:18:29 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 15:18:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:18:31 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 15:18:31 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 15:18:31 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 15:18:31 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 15:18:31 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 15:18:31 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 15:18:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:32 INFO - warning: no files found matching '*.txt' 15:18:32 INFO - no previously-included directories found matching 'build' 15:18:32 INFO - no previously-included directories found matching 'dist' 15:18:32 INFO - no previously-included directories found matching '.git*' 15:18:32 INFO - Installing collected packages: jsonschema, functools32 15:18:32 INFO - Running setup.py install for functools32 15:18:32 INFO - warning: no files found matching '*.txt' 15:18:32 INFO - no previously-included directories found matching 'build' 15:18:32 INFO - no previously-included directories found matching 'dist' 15:18:32 INFO - no previously-included directories found matching '.git*' 15:18:32 INFO - Successfully installed jsonschema functools32 15:18:32 INFO - Cleaning up... 15:18:32 INFO - Return code: 0 15:18:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:18:32 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')]} 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:32 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')]} 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:32 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:32 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 15:18:32 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 15:18:32 INFO - Using env: {'DISPLAY': ':0', 15:18:32 INFO - 'HOME': '/home/cltbld', 15:18:32 INFO - 'LANG': 'en_US.UTF-8', 15:18:32 INFO - 'LANGUAGE': 'en_US:en', 15:18:32 INFO - 'LOGNAME': 'cltbld', 15:18:32 INFO - 'MAIL': '/var/mail/cltbld', 15:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:32 INFO - 'MOZ_NO_REMOTE': '1', 15:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:32 INFO - 'NO_EM_RESTART': '1', 15:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:32 INFO - 'PWD': '/builds/slave/test', 15:18:32 INFO - 'SHELL': '/bin/bash', 15:18:32 INFO - 'SHLVL': '1', 15:18:32 INFO - 'TERM': 'linux', 15:18:32 INFO - 'TMOUT': '86400', 15:18:32 INFO - 'USER': 'cltbld', 15:18:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:32 INFO - '_': '/tools/buildbot/bin/python'} 15:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 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 15:18:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:18:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:35 INFO - Downloading docopt-0.6.1.tar.gz 15:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:35 INFO - Running setup.py install for blobuploader 15:18:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:18:35 INFO - Running setup.py install for requests 15:18:35 INFO - Running setup.py install for docopt 15:18:35 INFO - Successfully installed blobuploader requests docopt 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:35 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:35 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 15:18:35 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 15:18:35 INFO - Using env: {'DISPLAY': ':0', 15:18:35 INFO - 'HOME': '/home/cltbld', 15:18:35 INFO - 'LANG': 'en_US.UTF-8', 15:18:35 INFO - 'LANGUAGE': 'en_US:en', 15:18:35 INFO - 'LOGNAME': 'cltbld', 15:18:35 INFO - 'MAIL': '/var/mail/cltbld', 15:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:35 INFO - 'MOZ_NO_REMOTE': '1', 15:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:35 INFO - 'NO_EM_RESTART': '1', 15:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:35 INFO - 'PWD': '/builds/slave/test', 15:18:35 INFO - 'SHELL': '/bin/bash', 15:18:35 INFO - 'SHLVL': '1', 15:18:35 INFO - 'TERM': 'linux', 15:18:35 INFO - 'TMOUT': '86400', 15:18:35 INFO - 'USER': 'cltbld', 15:18:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:35 INFO - '_': '/tools/buildbot/bin/python'} 15:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:36 INFO - Running setup.py (path:/tmp/pip-ybHcix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:36 INFO - Running setup.py (path:/tmp/pip-l8ITrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:36 INFO - Running setup.py (path:/tmp/pip-LEtBlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:36 INFO - Running setup.py (path:/tmp/pip-o0I9vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:36 INFO - Running setup.py (path:/tmp/pip-dADOkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:36 INFO - Running setup.py (path:/tmp/pip-bVaAC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:36 INFO - Running setup.py (path:/tmp/pip-7Zv18F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:36 INFO - Running setup.py (path:/tmp/pip-vKaM5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:36 INFO - Running setup.py (path:/tmp/pip-O4Fo3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:36 INFO - Running setup.py (path:/tmp/pip-BuPilV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:36 INFO - Running setup.py (path:/tmp/pip-aSnml4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:36 INFO - Running setup.py (path:/tmp/pip-9wM5ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:36 INFO - Running setup.py (path:/tmp/pip-RGQO7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:36 INFO - Running setup.py (path:/tmp/pip-e9HdlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:37 INFO - Running setup.py (path:/tmp/pip-evrTYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:37 INFO - Running setup.py (path:/tmp/pip-Z8COCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:37 INFO - Running setup.py (path:/tmp/pip-Rf_Yt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:37 INFO - Running setup.py install for manifestparser 15:18:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozcrash 15:18:37 INFO - Running setup.py install for mozdebug 15:18:37 INFO - Running setup.py install for mozdevice 15:18:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozfile 15:18:37 INFO - Running setup.py install for mozhttpd 15:18:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozinfo 15:18:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozInstall 15:18:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozleak 15:18:38 INFO - Running setup.py install for mozlog 15:18:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for moznetwork 15:18:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozprocess 15:18:38 INFO - Running setup.py install for mozprofile 15:18:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozrunner 15:18:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozscreenshot 15:18:38 INFO - Running setup.py install for moztest 15:18:38 INFO - Running setup.py install for mozversion 15:18:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:18:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:39 INFO - Cleaning up... 15:18:39 INFO - Return code: 0 15:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:39 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:39 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 15:18:39 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 15:18:39 INFO - Using env: {'DISPLAY': ':0', 15:18:39 INFO - 'HOME': '/home/cltbld', 15:18:39 INFO - 'LANG': 'en_US.UTF-8', 15:18:39 INFO - 'LANGUAGE': 'en_US:en', 15:18:39 INFO - 'LOGNAME': 'cltbld', 15:18:39 INFO - 'MAIL': '/var/mail/cltbld', 15:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:39 INFO - 'MOZ_NO_REMOTE': '1', 15:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:39 INFO - 'NO_EM_RESTART': '1', 15:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:39 INFO - 'PWD': '/builds/slave/test', 15:18:39 INFO - 'SHELL': '/bin/bash', 15:18:39 INFO - 'SHLVL': '1', 15:18:39 INFO - 'TERM': 'linux', 15:18:39 INFO - 'TMOUT': '86400', 15:18:39 INFO - 'USER': 'cltbld', 15:18:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:39 INFO - '_': '/tools/buildbot/bin/python'} 15:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:39 INFO - Running setup.py (path:/tmp/pip-AbUUGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:39 INFO - Running setup.py (path:/tmp/pip-PoZ9Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:39 INFO - Running setup.py (path:/tmp/pip-dtukAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:39 INFO - Running setup.py (path:/tmp/pip-ariMwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:39 INFO - Running setup.py (path:/tmp/pip-c9EYUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:39 INFO - Running setup.py (path:/tmp/pip-UkCcp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:39 INFO - Running setup.py (path:/tmp/pip-BEaUej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:39 INFO - Running setup.py (path:/tmp/pip-yTZeJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:39 INFO - Running setup.py (path:/tmp/pip-uKS5rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:39 INFO - Running setup.py (path:/tmp/pip-Zmvv6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:39 INFO - Running setup.py (path:/tmp/pip-p7nPdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:40 INFO - Running setup.py (path:/tmp/pip-AK_CQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:40 INFO - Running setup.py (path:/tmp/pip-MUvjZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:40 INFO - Running setup.py (path:/tmp/pip-s15c1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:40 INFO - Running setup.py (path:/tmp/pip-1pEJq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:40 INFO - Running setup.py (path:/tmp/pip-RfY7wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:40 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)) 15:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:40 INFO - Running setup.py (path:/tmp/pip-tfzH0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:40 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 15:18:40 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 15:18:40 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 15:18:40 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 15:18:40 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 15:18:40 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 15:18:42 INFO - Downloading blessings-1.6.tar.gz 15:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:42 INFO - Installing collected packages: blessings 15:18:42 INFO - Running setup.py install for blessings 15:18:42 INFO - Successfully installed blessings 15:18:42 INFO - Cleaning up... 15:18:42 INFO - Return code: 0 15:18:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:42 INFO - Reading from file tmpfile_stdout 15:18:42 INFO - Current package versions: 15:18:42 INFO - argparse == 1.2.1 15:18:42 INFO - blessings == 1.6 15:18:42 INFO - blobuploader == 1.2.4 15:18:42 INFO - docopt == 0.6.1 15:18:42 INFO - functools32 == 3.2.3-2 15:18:42 INFO - jsonschema == 2.5.1 15:18:42 INFO - manifestparser == 1.1 15:18:42 INFO - mozInstall == 1.12 15:18:42 INFO - mozcrash == 0.17 15:18:42 INFO - mozdebug == 0.1 15:18:42 INFO - mozdevice == 0.48 15:18:42 INFO - mozfile == 1.2 15:18:42 INFO - mozhttpd == 0.7 15:18:42 INFO - mozinfo == 0.9 15:18:42 INFO - mozleak == 0.1 15:18:42 INFO - mozlog == 3.2 15:18:42 INFO - moznetwork == 0.27 15:18:42 INFO - mozprocess == 0.22 15:18:42 INFO - mozprofile == 0.28 15:18:42 INFO - mozrunner == 6.11 15:18:42 INFO - mozscreenshot == 0.1 15:18:42 INFO - mozsystemmonitor == 0.3 15:18:42 INFO - moztest == 0.7 15:18:42 INFO - mozversion == 1.4 15:18:42 INFO - psutil == 3.1.1 15:18:42 INFO - requests == 1.2.3 15:18:42 INFO - wsgiref == 0.1.2 15:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:42 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:42 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 15:18:42 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 15:18:42 INFO - Using env: {'DISPLAY': ':0', 15:18:42 INFO - 'HOME': '/home/cltbld', 15:18:42 INFO - 'LANG': 'en_US.UTF-8', 15:18:42 INFO - 'LANGUAGE': 'en_US:en', 15:18:42 INFO - 'LOGNAME': 'cltbld', 15:18:42 INFO - 'MAIL': '/var/mail/cltbld', 15:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:42 INFO - 'MOZ_NO_REMOTE': '1', 15:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:42 INFO - 'NO_EM_RESTART': '1', 15:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:42 INFO - 'PWD': '/builds/slave/test', 15:18:42 INFO - 'SHELL': '/bin/bash', 15:18:42 INFO - 'SHLVL': '1', 15:18:42 INFO - 'TERM': 'linux', 15:18:42 INFO - 'TMOUT': '86400', 15:18:42 INFO - 'USER': 'cltbld', 15:18:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:42 INFO - '_': '/tools/buildbot/bin/python'} 15:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 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)) 15:18:43 INFO - Cleaning up... 15:18:43 INFO - Return code: 0 15:18:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:43 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:43 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 15:18:43 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 15:18:43 INFO - Using env: {'DISPLAY': ':0', 15:18:43 INFO - 'HOME': '/home/cltbld', 15:18:43 INFO - 'LANG': 'en_US.UTF-8', 15:18:43 INFO - 'LANGUAGE': 'en_US:en', 15:18:43 INFO - 'LOGNAME': 'cltbld', 15:18:43 INFO - 'MAIL': '/var/mail/cltbld', 15:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:43 INFO - 'MOZ_NO_REMOTE': '1', 15:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:43 INFO - 'NO_EM_RESTART': '1', 15:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:43 INFO - 'PWD': '/builds/slave/test', 15:18:43 INFO - 'SHELL': '/bin/bash', 15:18:43 INFO - 'SHLVL': '1', 15:18:43 INFO - 'TERM': 'linux', 15:18:43 INFO - 'TMOUT': '86400', 15:18:43 INFO - 'USER': 'cltbld', 15:18:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:43 INFO - '_': '/tools/buildbot/bin/python'} 15:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:43 INFO - Cleaning up... 15:18:43 INFO - Return code: 0 15:18:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:43 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 0x7f0267a33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bce020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', '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 15:18:43 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 15:18:43 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 15:18:43 INFO - Using env: {'DISPLAY': ':0', 15:18:43 INFO - 'HOME': '/home/cltbld', 15:18:43 INFO - 'LANG': 'en_US.UTF-8', 15:18:43 INFO - 'LANGUAGE': 'en_US:en', 15:18:43 INFO - 'LOGNAME': 'cltbld', 15:18:43 INFO - 'MAIL': '/var/mail/cltbld', 15:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:43 INFO - 'MOZ_NO_REMOTE': '1', 15:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:43 INFO - 'NO_EM_RESTART': '1', 15:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:43 INFO - 'PWD': '/builds/slave/test', 15:18:43 INFO - 'SHELL': '/bin/bash', 15:18:43 INFO - 'SHLVL': '1', 15:18:43 INFO - 'TERM': 'linux', 15:18:43 INFO - 'TMOUT': '86400', 15:18:43 INFO - 'USER': 'cltbld', 15:18:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:43 INFO - '_': '/tools/buildbot/bin/python'} 15:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:43 INFO - Downloading/unpacking flake8 15:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:45 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 15:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:46 INFO - no previously-included directories found matching 'docs/_build' 15:18:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:46 INFO - Running setup.py install for pep8 15:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:46 INFO - no previously-included directories found matching 'docs/_build' 15:18:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:46 INFO - Cleaning up... 15:18:46 INFO - Return code: 0 15:18:46 INFO - Running post-action listener: _resource_record_post_action 15:18:46 INFO - Running post-action listener: _start_resource_monitoring 15:18:46 INFO - Starting resource monitoring. 15:18:46 INFO - ##### 15:18:46 INFO - ##### Finished create-virtualenv step (success) 15:18:46 INFO - ##### 15:18:46 INFO - ##### 15:18:46 INFO - ##### Running install step. 15:18:46 INFO - ##### 15:18:46 INFO - Running pre-action listener: _resource_record_pre_action 15:18:46 INFO - Running main action method: install 15:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:46 INFO - Reading from file tmpfile_stdout 15:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:46 INFO - Reading from file tmpfile_stdout 15:18:46 INFO - Output received: 15:18:46 INFO - Usage: mozinstall [options] installer 15:18:46 INFO - Options: 15:18:46 INFO - -h, --help show this help message and exit 15:18:46 INFO - -d DEST, --destination=DEST 15:18:46 INFO - Directory to install application into. [default: 15:18:46 INFO - "/builds/slave/test"] 15:18:46 INFO - --app=APP Application being installed. [default: firefox] 15:18:46 INFO - mkdir: /builds/slave/test/build/application 15:18:46 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'] 15:18:46 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 15:19:02 INFO - Reading from file tmpfile_stdout 15:19:02 INFO - Output received: 15:19:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:02 INFO - Running post-action listener: _resource_record_post_action 15:19:02 INFO - ##### 15:19:02 INFO - ##### Finished install step (success) 15:19:02 INFO - ##### 15:19:02 INFO - ##### 15:19:02 INFO - ##### Running run-tests step. 15:19:02 INFO - ##### 15:19:02 INFO - Running pre-action listener: _resource_record_pre_action 15:19:02 INFO - Running main action method: run_tests 15:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:02 INFO - Python 2.7.3 15:19:02 INFO - Return code: 0 15:19:02 INFO - grabbing minidump binary from tooltool 15:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:02 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 0x1c602e0>, '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 0x1bcc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:02 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 15:19:02 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 15:19:02 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 15:19:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:02 INFO - Return code: 0 15:19:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:19:03 INFO - Return code: 0 15:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:19:03 INFO - Using env: {'DISPLAY': ':0', 15:19:03 INFO - 'HOME': '/home/cltbld', 15:19:03 INFO - 'LANG': 'en_US.UTF-8', 15:19:03 INFO - 'LANGUAGE': 'en_US:en', 15:19:03 INFO - 'LOGNAME': 'cltbld', 15:19:03 INFO - 'MAIL': '/var/mail/cltbld', 15:19:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:03 INFO - 'MOZ_NO_REMOTE': '1', 15:19:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:03 INFO - 'NO_EM_RESTART': '1', 15:19:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:03 INFO - 'PWD': '/builds/slave/test', 15:19:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:03 INFO - 'SHELL': '/bin/bash', 15:19:03 INFO - 'SHLVL': '1', 15:19:03 INFO - 'TERM': 'linux', 15:19:03 INFO - 'TMOUT': '86400', 15:19:03 INFO - 'USER': 'cltbld', 15:19:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620', 15:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:03 INFO - '_': '/tools/buildbot/bin/python'} 15:19:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:19:04 INFO - mozversion application_buildid: 20160710123925 15:19:04 INFO - mozversion application_changeset: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf 15:19:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:19:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:04 INFO - mozversion application_name: Firefox 15:19:04 INFO - mozversion application_remotingname: firefox-dev 15:19:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:04 INFO - mozversion application_vendor: Mozilla 15:19:04 INFO - mozversion application_version: 49.0a2 15:19:04 INFO - mozversion platform_buildid: 20160710123925 15:19:04 INFO - mozversion platform_changeset: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf 15:19:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:04 INFO - mozversion platform_version: 49.0a2 15:19:04 INFO - using testdate: 1468189144 15:19:04 INFO - actual date: 1468189144 15:19:04 INFO - starting webserver on 'localhost:40918' 15:19:04 INFO - SUITE-START | Running 2 tests 15:19:04 INFO - TEST-START | dromaeo_css 15:19:04 INFO - operating with platform_type : linux_ 15:19:04 INFO - Initialising browser for dromaeo_css test... 15:19:04 INFO - TEST-INFO | started process 3352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIkjxU/profile http://localhost:40918/getInfo.html) 15:19:09 INFO - PROCESS | 3352 | __metrics Screen width/height:1600/1200 15:19:09 INFO - PROCESS | 3352 | colorDepth:24 15:19:09 INFO - PROCESS | 3352 | Browser inner width/height: 1024/697 15:19:09 INFO - PROCESS | 3352 | __metrics 15:19:10 ERROR - PROCESS | 3352 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:19:11 INFO - TEST-INFO | 3352: exit 0 15:19:11 INFO - Browser initialized. 15:19:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:11 INFO - TEST-INFO | started process 3446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIkjxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:22 INFO - PROCESS | 3446 | RSS: Main: 145555456 15:19:22 INFO - PROCESS | 3446 | 15:20:13 INFO - PROCESS | 3446 | 1468189213537 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] 15:22:22 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40918/tests/dromaeo/cssquery-ext.html) 15:22:23 INFO - PROCESS | 3446 | RSS: Main: 255504384 15:22:23 INFO - PROCESS | 3446 | 15:25:25 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-ext.html (next: http://localhost:40918/tests/dromaeo/cssquery-jquery.html) 15:25:26 INFO - PROCESS | 3446 | RSS: Main: 227950592 15:25:26 INFO - PROCESS | 3446 | 15:28:28 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40918/tests/dromaeo/cssquery-mootools.html) 15:28:28 INFO - PROCESS | 3446 | RSS: Main: 227119104 15:28:28 INFO - PROCESS | 3446 | 15:31:30 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40918/tests/dromaeo/cssquery-prototype.html) 15:31:31 INFO - PROCESS | 3446 | RSS: Main: 223555584 15:31:31 INFO - PROCESS | 3446 | 15:34:33 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40918/tests/dromaeo/cssquery-yui.html) 15:34:34 INFO - PROCESS | 3446 | RSS: Main: 213778432 15:34:34 INFO - PROCESS | 3446 | 15:37:36 INFO - PROCESS | 3446 | Cycle 1(1): loaded http://localhost:40918/tests/dromaeo/cssquery-yui.html (next: http://localhost:40918/tests/dromaeo/cssquery-dojo.html) 15:37:37 INFO - PROCESS | 3446 | RSS: Main: 262266880 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | __start_tp_report 15:37:37 INFO - PROCESS | 3446 | _x_x_mozilla_page_load 15:37:37 INFO - PROCESS | 3446 | _x_x_mozilla_page_load_details 15:37:37 INFO - PROCESS | 3446 | |i|pagename|runs| 15:37:37 INFO - PROCESS | 3446 | |0;dojo.html;3316.883909063183;3337.415952208363;3367.612724536679;3386.7629265951377;3389.7288216942616;5586.944130558693;5639.2668953036155;5665.320161580611;5674.716264186784;5699.658020518761;5536.390996990328;5590.888182236353;5596.356419011805;5596.636218645795;5599.524040456556;5037.949620503803;5058.4435712071645;5060.9878024395175;5081.8221362252325;5099.005693889674;5068.163752980754;5082.593392528589;5084.084864724348;5137.922931156036;5174.534291913746;5096.235564665293;5130.204818253177;5193.350831146106;5204.9739751301195;5206.921896171561;5096.847094587169;5119.872003199913;5185.818496352628;5189.714565698885;5215.4523775003645;4929.580985616227;4964.05682920244;4972.701637901738;5010.123228435009;5019.723915184663;5458.890822183574;5459.208414779874;5476.479734425223;5501.284832971728;5515.283013208297;5842;5914;5958.374370691102;5960.7019649017375;5965.463108320272;5897.852553686149;5913.438223368773;5948.881022379572;6056.204924148222;6085.996914058;5657.886842263173;5686.744096515667;5692.260006199209;5695.7152142392715;5696.51579615729;6069.726862291208;6077.787277445356;6110.419510146529;6189.381061893865;6190.3190649028575;5950.434708702666;5960.761569537257;5977.342492325841;6008.909866352008;6012.609180403348;5957.582969192115;5983.072623743326;5998.190244317048;6012.699365031731;6029.788957386558;5839.503642190376;5890.14592884038;5921.585489015728;5945.346011938684;5949.970250148722;5996.220491336098;6020.849478762978;6034.637921724623;6051.667158306247;6069.969650151809;4608.97695511527;4621.4223222097235;4628.3288923105965;4629.791659375336;4648.953510464919;4036.2129384770274;4071.0840060986043;4073.490813648294;4129.174165166918;4151.97924010378;5666.943330566724;5684.175794509773;5704.543636509069;5705.857353566111;5706.629069110494;6042.758289668452;6047.606905551125;6051.878962420727;6057.242844644419;6076.635401875901;5530.557555395559;5623.156526520973;5662.6036177468;5679.488846003796;5686.061799803069;5202.869928251748;5204.947950520522;5205.947940520547;5208.348956380452;5230;6319.24169099711;6323.936760632427;6327.019312006739;6338.366163383717;6345.270293916259;5896.056630939029;6007.579469437097;6067.787627433018;6081.118237855575;6135.7238924249405;6327.303996560467;6338.492920566436;6357.300696923242;6364.363563643598;6368;5744.712764361849;5978.790742323998;5985.880282394415;5987;5999.370066143167;5925.200097986716;5951.672658003851;5970.283565972111;6014.127951446928;6033.125196846345;5808.854778630568;5852.912206316823;5854.268216472941;5870.412958704266;5887.646741195542;5789.044807606698;5805.41945805433;5809.564282678732;5848.912266316093;5849.53203743708;5752.6836024019085;5844.883102337844;5852.502537284208;5855.677937713466;5881.2942446906645;5918.496927761016;5941.168236446987;5978.880422391615;5986.700664966647;5995.280566332068;5677.460641239076;5740.3685594585395;5780.421957804186;5810.070388737781;5835 15:37:37 INFO - PROCESS | 3446 | |1;ext.html;604.356360476093;647.0908373734902;650.8600650860064;654.2704884054278;662.7580932959471;33809.66190338096;47187.528124718745;47621;47952.520474795245;48077.519224807744;50080.24879626808;50670.98658026837;50681.746591266994;50781.49218507814;50792.238116428285;8323.791905202357;9073.138051885076;9193.080691930787;10020.34867733595;10242.743931401737;10916.290441121302;11010.944945275263;11027.117830573576;11028.558857645685;11039.282446640982;11150.330980141176;11194.440277986108;11198.440077996067;11204;11222.943885280562;8469.32245420365;10897.291676041032;11055.281406708538;11064.391458469781;11462.312261264351;10866.782664346669;10896.782064358747;10922.726931826688;10924.453777311102;10953.014228719454;45410;45648.77175614134;45742.54257457416;45816.312755308696;45887.311690324335;3661.8535258589623;3673.1184515716304;3841.4621952926614;4080.0207950092063;4270.871873843789;34747;35188.47217291743;35394.64605353939;35470.64529354699;35646.643533564595;4344.56554344563;4351.61356158314;4387;4394.274944634131;4465.062336909253;358070;358841;358925;359940;360253.19873400725;38506.61493385086;39425.40861887017;39434.2113157741;67288.65422691617;68067.65966170236;40970.590294097274;40988.59011409848;41131;41166.176676466304;41343.7932810334;14993.100413975197;17133.742993855103;17235.052072136154;17256.74114888278;17257.137143142794;14208.64478388028;14455.27723613815;14476.203808790407;14769;14791.408343666348;9175.58709858058;9178.954105229432;9207.86188207164;9234.660974158844;9261.30540209487;3443.8622455101518;3444.741644376682;3501.352249833789;3507.0881570791266;3531.434970404723;1006.4716024087413;1072.6245813965206;1093.814051611228;1156.2946602572424;1171.478691982077;34119.31761364808;34296.828515857764;35012;35166.296674066376;35453.468197977054;1094.5293523784849;1158.7624536969902;1195.964121076369;1199.112656634102;1205.1985429689335;17993.64012719738;17994.5501362467;18263.72604410935;18358.357457488924;18400.63198736018;645827;651083;652892;653960;655906;65063;66497.33502665008;66910.66544667343;67139.32860671429;67201.66399167973;1389.7567925612977;1405.5713007532597;1420.2330741399528;1524.9847501524844;1527.877769778415;28704.282392940342;34588.30823383568;35078.29843403168;37164.628353716114;37722.81138594289;63622.68188659027;64117.67941160264;64185;64211.678941604994;64250;547315;549226.2538687281;550328;550371;550732;31782.205444864063;31897.044709766447;32259.193520162185;32407.189820254684;32469.67530324761;52806;52905;54010.18984715311;54166.18750718821;55816.720916395156;44589.554104459836;44917.32624010577;45446.77276613728;46292.53707463017;46410.53589464062;44277.55722442863;45547;45679.543204567526;45683.54316456793;47238.52761472341;44937;45384.319235212155;45418.31872521849;45570;45803.3129503051;38119.80940095282;39965.40051899282;40274.79175624736;40316.3952540718;40834;30465.695343046285;30699.846500767355;30804.691953080182;31205;31451.370972580877 15:37:37 INFO - PROCESS | 3446 | |2;jquery.html;421.81861799426235;422.55420531339433;437.7329828804429;438.1631084628356;439.58459256003067;19167.712484312713;19576.804231957674;20121.396358109243;20217.090230939608;20559.794402055973;17760.200790964405;18266.634667306647;18606;19293.807061929376;19297.517562060955;5616.663000219979;5768.336641286242;5802.970985145068;5804.477597016267;5809.419058094178;4283.614474697277;4830.758462076899;5735;5786.768529258825;6347.555671103025;6449.8710025799455;6469.35306469354;6470.450011749007;6480.935190648104;6482.902756458657;6229.4704950079295;6431.421172094487;6439;6440.871182576346;6463.806085817433;3881.146147847469;5299.258103865462;5593.916091258634;5604.131359639263;5627.465390787909;22622.321330360115;23281.883590582107;23323.183688570818;23344.883275583514;23536.411589710395;2346.2961111666605;2414.4929564791414;2438.3904023994;2469.7283298837115;2507.260358194337;14483.565493035227;14708;14970.775438368324;15002.62493437662;15279.618009549738;2042.77529471758;2060.268604645344;2068.389825001628;2092.4664210626192;2156.579467003935;58153;67692;82342;84943;87068.99999999936;10936.945315273373;11051.17116216287;11155.665330040112;11576.710582235342;11645.12661550387;16341.101239431946;16479.34082636705;16485.17574121313;16493.917530412273;16511.256993435323;8883.067277935854;8972.506512141896;9094.408863423856;9155.359124861328;9217.124373184537;8572;8665.956670216734;8942.776430589158;8991.910080899239;8991.995685759453;6890.414314783199;7064.258252883476;7089.751858684921;7112.5112421801305;7182.174049984214;2050.9077091530917;2088.5614021055444;2126.362091372613;2128.9893550532147;2135.135270215565;448.4887228559445;972.9513524323755;1035.089121573011;1048.6434612231878;1094.534822700365;11078.5568577256;11876.0499160067;11975.161738678209;11985.52057917691;12008.63974080779;486.6860874735846;494.5287768887531;495.44360002571335;503.53674619350284;511.60095125801934;6312.274088479791;6313.210848643919;6334.714937827809;6346.619202847844;6383.904241436382;402264;407238;409846;526929;530097;89888.5505572481;100479.49760251152;106331.4683426578;107572;109172.4541377304;1093.573506332531;1133.0425790207262;1152.9047404965318;1153.6712037069394;1155.4627098399285;17663.470095897144;17749.378771742926;17788.91105544464;17789.110544472984;18212.908935455238;39439.408408873314;40888.79555602203;42662.78668606637;42785;43784.56215437805;58854.7057264711;59947.700261498416;59975.70012149911;60263.397366025776;61467.692661538196;8237.876431853647;8463;8478.23695867375;8610.13898610159;8624;10044.54799534008;11731.706707332385;12502.312372819582;13823.723525529233;13870.791938120734;11472.598459053894;11749.647510574696;12195.634130976085;12416.037257067754;12450.25298482094;11619.128565357463;11818.231814932002;11932.403379830801;11953.402329883296;12156.696082598006;12018.158728888893;12039.157258992136;12058.216215945935;12282.140250182401;12379.690507737017;7588.772336829904;7968.282854543119;8146;8563.058063612873;8597.742067737978;9048.50233237152;12329.815052774036;12436.440360183995;12621.81067283973;12621.810672840098 15:37:37 INFO - PROCESS | 3446 | |3;mootools.html;1396.4135063273425;1540.5686407805815;1587.9841201587985;1736.3141559084163;1909.2076788132927;8966.86549701755;9346.299027572943;9348.953255233722;9556.617735290598;9562.043795620435;9154.49650269235;9384.436933783978;9477.14705676489;9479.241660667147;9486.193673537757;2143.807057364837;2199.582079404916;2209.0501084533644;2429.574824405731;2480.8015358771345;2388.462595915914;2460.963085553718;2464.4578192797558;2471.8258827057093;2473.5423946569854;2374.394529395002;2402.1832576923844;2411.686480757499;2421.709394872618;2424.9151279705216;2110.7889211078923;2383.6305372667266;2418.7823095921362;2452.460458699083;2456.91400800972;2406.470576473173;2436.7441418650965;2436.8416052956677;2437.622168563875;2439.6462512935523;9162.541872906395;9267.02696216901;9271.165595096474;9275.58259878307;9279.257659387233;5377.381601115882;5491.176323551499;5506.91739623902;5514.696691681956;5520;3328.334333133359;3434.939036578058;3492.772969756983;3518.9472157917653;3527.224010717638;1116.7152376144113;1144.1876267849836;1146.6789298996293;1157.5196293538172;1175.8530183727034;13136.60590182296;13165.341732913315;13168.473261069546;13183.802242966363;13195.20828750278;4781.713097214179;4812.663113582085;4854.587360074363;4874.488178741181;4917.5082491751255;11271.54913803455;11276.267042642203;11281;11300.265482743594;11315.434228288552;5583.748731307101;5587.804426845041;5588.692621905753;5593.776248950077;5598.832035038955;4498.437695288089;5051.722155281422;5117.8464646060675;5188.8962220755375;5197.740112994411;4176.665866730655;4196;4277.871663850089;4338.58783415575;4344.066025804467;1336.8729970652967;1361.6663917340315;1362.2371471975725;1364.6997660514671;1377.9055835130746;936.1855185988234;980.1668581705493;1067.4982758103679;1080.303204433152;1090.8800031996475;6368.904466433008;6453.386928241809;6511.869762604816;6532.510061745388;6585.571937824122;491.6976059723316;499.62777730590216;501.1105288113555;502.7184776525158;504.23104765233313;4056.229316429869;4139.627433530996;4247.299195632748;4251.87244382669;4337.175936572041;11505.194636375374;11982.940085299517;12036.037117030617;12071.155019148751;12080.335581542924;11661;11747.647570572897;11798.587049453228;11819.113566482549;11855;8260.173982601691;8593.269572086318;8642.827143457222;8789.428687135316;8883.600237989305;6568.7372505099265;6660.933390666225;6769.323067693388;6812.080369150101;6815.795526134026;10639.18061713631;10921.563137474412;10962.232643714864;11023.17326200522;11128.777424451304;11205.439728013404;11276.703179134176;11312.095032397554;11330.546778129112;11331.376774277163;7512.5492470451945;8237.217464340878;8389.706360277361;8440.324774017941;8493.57532123379;9286.582103805209;9304.116108969638;9344.719658410258;9375.578098985425;9383.108604682544;8169.877451838108;8382.49705017701;8385.37109716786;8475.83048339042;8507.574621269036;8211.83576328482;8294.958525207578;8327.042390125212;8423.789405264917;8433.662653494037;7627.8855817161675;7808.063032436144;7813.726519572015;7820.491668041559;7835.412344074103;5817.331006934257;5837.532997360286;5936.228290322403;5963.463288304073;5982.581219314607;5461.699606521679;5576.972115139399;5726.65640061581;5796.884062318646;6021.638701677738 15:37:37 INFO - PROCESS | 3446 | |4;prototype.html;341.19307836965584;346.61179478983536;355.5662092247458;356.9914990152819;359.7427839095046;5375.387383784869;5518.2826232589805;5584.888302233958;5589.357223919245;5618.971905140474;5489.560835133189;5504.284443022411;5514.200440936062;5516.889662206753;5520.944790552104;4322.50291216511;4345.587169218919;4350.738955662655;4374.693771436001;4391.758453285068;4227.978860105695;4358.757754040099;4363.629091527224;4375.606195442426;4379.189849877783;4272.205673617088;4297.892552686192;4301.3547967804925;4323.524412314643;4328.84849030284;4301.892452688677;4321.762303073329;4321.935170972438;4324.416203812477;4335.804888780012;3670.4861319415304;3770.454113813351;3771.283456143324;3787.450819631138;3791.658750712449;5351.57187425005;5354.571634269288;5365;5372.838814835562;5381.569474442035;4953.628477864175;4953.826616068421;4965.106280869442;4968.677035992649;4970.204767237261;5605.7197140142825;5791.88416231673;5792.565557583156;5794.449527294901;5809.506191973687;4168.166366726667;4182.811773470201;4185.434966279544;4204.474440694913;4217.873463796061;5804.21643078179;6053.969730151321;6071.574989750719;6074.693940802748;6123.87752244957;4211.473565804275;4232.174725928476;4255.659547236213;4258.1057977824385;4281.828726850891;4294.914101717948;4299.011227417712;4331.242032644274;4333.306670932636;4334.263175260214;4856.975715121402;4893.455403190321;4908.460069392364;4915.975420122876;4959.156943319645;5485.725713714299;5541.307336582927;5769.798057067983;5780.439281394084;5810.564207684441;1434.3760464198108;1463.6706740983193;1469.7721853112785;1469.9853001469849;1472.7938088667595;934.8177105464505;946.3659348236698;966.9806603867884;969.0454901921602;973.026973026973;5009.398872135367;5027.748612569357;5034.169362055293;5038.84883453497;5041.319421878073;5246.816361427332;5270.736463176826;5283.709395983258;5290.973545132327;5306.52241298285;4580.450345958439;4981.252812078144;4995.325631039836;5002.699838009731;5058.645894787403;2787.8466684332557;2798.816922800219;2815.81697189682;2825.4914115459005;2830.532962061278;5434.864128396822;5439.5104440600535;5456.372517160577;5473.261109750212;5476.288082549323;5101.20931255656;5315.681059136464;5371.838844834661;5385.7307134643115;5386.461353864583;5509.586780991522;5517.475839795213;5527.861803454865;5536.56391187876;5561.833145005576;5218.608604354613;5226.372835259793;5252.632315737862;5255.632105752714;5259.631825772312;4869.829555965524;5180.818671346485;5193.2608521864195;5222.9108356656125;5232.869178270574;5384.6615098639095;5405.513403895128;5413.83758487246;5434.619576629756;5459.808906688247;3861.7489863158803;3877.340852055101;3886.7279290449396;3894.3963685628773;3902.726809123334;5558.944410555842;5734.512566431733;5754.9424505754405;6025.457708806229;6057.454829065406;5758.2725182444265;5793.8551536211935;5811.738471768696;5835.912461313169;5839.299284085937;5793.275840519935;5800.8259752207505;5807.477327040587;5817.301923769006;5819.82540523785;5604.551635869039;5726.112452569859;5739.684317362585;5740.856478588069;5749.396313387201;5797.565182611237;5802.912956305574;5819.970900145472;5852.50761055928;5859.736311865891;5407.432219617041;5676.659400435987;5682.181701855367;5702.3178162441345;5764.884702306014 15:37:37 INFO - PROCESS | 3446 | |5;yui.html;777.2616014785951;791.3787676673812;797.7925739307778;887.6582515731443;902.9232515236205;14541.636459088528;14561.199134047623;14596.197209153492;15300.923495382522;15367.769483457743;15128.319225634845;15190.848091519081;15310.693786124271;15328.770068448983;15342.616434589141;729.0740759235767;860.9655613775442;876.7325965580495;882.7219425880859;891.1445012787732;881.6870011146048;884.1512148337604;887.8756974023642;888.2316795971502;888.4447220487195;935.3172184305461;935.7099299217231;936.204226407555;936.66748304352;937.3298091864316;758.6548120605139;900.7973206028656;924.4268553496807;926.8609708543738;928.8792456980549;685.5372623479132;686.255412877029;686.9690863911136;687.3367200651395;687.3573209049555;14420.783688244685;14422.350994205286;14454.205018723966;14462.566123016326;14495.42018319266;14630.26848657563;14704.779428308584;14804.555863324118;15028.398864045424;15166.924165379212;12035.976941959943;12043.458044387937;12119.272843629411;14146.151230926178;14334.354954027094;4810.326554282403;4822.541858523435;4830.541098595628;4910.582600478963;4979.053979743873;78911;81837.59081204615;82677.17322826755;82924;82975.585122074;11150.776984460266;11158.665240042812;12185.573504927284;12341.3829308536;12361.320127393079;20912.37262882116;20961.47596310074;20970.266040688504;20973.790262097184;20982.68525972112;8973.28213742912;9167.724968250963;9168.633254669738;9190.678326258549;9356.064393560726;4854;4898.975505122523;4925.507449255046;4941.654084214142;5063.392392912874;3624.130208749881;3685.5577330720484;3688.5389326334207;3712.9443058354145;3718.3678774608384;592.2182718811214;605.6517502436117;614.2966303582373;626.4049153304288;630.7413960276265;693.8889777635655;712.2023333866103;721.3579913876654;737.4874462248686;773.818152734107;10572.36565806054;10629.30909490896;10687.89312106869;10691.069800626226;10735.731606709738;614.797116951405;689.5729417141961;716.913970323554;769.5267410542476;775.7091090840935;4701.576858082789;4833.604584984979;4839.475565196952;4843.878903027453;4993.950060499421;74369.25630743623;114255.42872285585;117070.6585868295;117486;123514.38242808728;102017;103102;104098.47950760198;104730;105004;59848.70075649594;69454.65272673705;93727;94536.10927781406;95041;9385.530723463937;9410.670626528039;9421.38760980534;9526.904730952601;9620.428907896368;55714.442855572546;56345.43654563402;56702.43297567136;56775.14837277361;57571.424285756606;73968.63015684887;82111;83453.58273208595;83737.16262837537;84620.57689711513;12143.81784273219;12281.631551053482;13139.408726607135;14109.858901410855;14139.363728632443;15088.24558772079;15701.685966280382;15774.763378549102;16050;16086.276117574504;14498.855011450172;14553.781693274397;14823.110613363233;15531.5340539784;15856.841431585997;14131.15213087218;14222.786658200343;15512.224388780742;15688.215589220265;15712.371505139667;14786.778198326818;14858.925705371405;15094.39622415091;15454.84545154579;15989.920050399674;11685.240459370114;12266.202696824677;12784.61646150617;13094.345282735634;13109.213447192817;12830.87169128334;13158.868411315765;13164.47342106305;13497.797533037208;13569.864301357255 15:37:37 INFO - PROCESS | 3446 | __end_tp_report 15:37:37 INFO - PROCESS | 3446 | __start_cc_report 15:37:37 INFO - PROCESS | 3446 | _x_x_mozilla_cycle_collect,916 15:37:37 INFO - PROCESS | 3446 | __end_cc_report 15:37:37 INFO - PROCESS | 3446 | __startTimestamp1468190257106__endTimestamp 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | ------- Summary: start ------- 15:37:37 INFO - PROCESS | 3446 | Number of tests: 6 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#0] dojo.html Cycles:165 Average:5588.06 Median:5808.85 stddev:628.82 (10.8%) stddev-sans-first:604.98 15:37:37 INFO - PROCESS | 3446 | Values: 3316.9 3337.4 3367.6 3386.8 3389.7 5586.9 5639.3 5665.3 5674.7 5699.7 5536.4 5590.9 5596.4 5596.6 5599.5 5037.9 5058.4 5061.0 5081.8 5099.0 5068.2 5082.6 5084.1 5137.9 5174.5 5096.2 5130.2 5193.4 5205.0 5206.9 5096.8 5119.9 5185.8 5189.7 5215.5 4929.6 4964.1 4972.7 5010.1 5019.7 5458.9 5459.2 5476.5 5501.3 5515.3 5842.0 5914.0 5958.4 5960.7 5965.5 5897.9 5913.4 5948.9 6056.2 6086.0 5657.9 5686.7 5692.3 5695.7 5696.5 6069.7 6077.8 6110.4 6189.4 6190.3 5950.4 5960.8 5977.3 6008.9 6012.6 5957.6 5983.1 5998.2 6012.7 6029.8 5839.5 5890.1 5921.6 5945.3 5950.0 5996.2 6020.8 6034.6 6051.7 6070.0 4609.0 4621.4 4628.3 4629.8 4649.0 4036.2 4071.1 4073.5 4129.2 4152.0 5666.9 5684.2 5704.5 5705.9 5706.6 6042.8 6047.6 6051.9 6057.2 6076.6 5530.6 5623.2 5662.6 5679.5 5686.1 5202.9 5204.9 5205.9 5208.3 5230.0 6319.2 6323.9 6327.0 6338.4 6345.3 5896.1 6007.6 6067.8 6081.1 6135.7 6327.3 6338.5 6357.3 6364.4 6368.0 5744.7 5978.8 5985.9 5987.0 5999.4 5925.2 5951.7 5970.3 6014.1 6033.1 5808.9 5852.9 5854.3 5870.4 5887.6 5789.0 5805.4 5809.6 5848.9 5849.5 5752.7 5844.9 5852.5 5855.7 5881.3 5918.5 5941.2 5978.9 5986.7 5995.3 5677.5 5740.4 5780.4 5810.1 5835.0 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#1] ext.html Cycles:180 Average:68070.56 Median:21174.04 stddev:142493.67 (673.0%) stddev-sans-first:142803.37 15:37:37 INFO - PROCESS | 3446 | Values: 604.4 647.1 650.9 654.3 662.8 33809.7 47187.5 47621.0 47952.5 48077.5 50080.2 50671.0 50681.7 50781.5 50792.2 8323.8 9073.1 9193.1 10020.3 10242.7 10916.3 11010.9 11027.1 11028.6 11039.3 11150.3 11194.4 11198.4 11204.0 11222.9 8469.3 10897.3 11055.3 11064.4 11462.3 10866.8 10896.8 10922.7 10924.5 10953.0 45410.0 45648.8 45742.5 45816.3 45887.3 3661.9 3673.1 3841.5 4080.0 4270.9 34747.0 35188.5 35394.6 35470.6 35646.6 4344.6 4351.6 4387.0 4394.3 4465.1 358070.0 358841.0 358925.0 359940.0 360253.2 38506.6 39425.4 39434.2 67288.7 68067.7 40970.6 40988.6 41131.0 41166.2 41343.8 14993.1 17133.7 17235.1 17256.7 17257.1 14208.6 14455.3 14476.2 14769.0 14791.4 9175.6 9179.0 9207.9 9234.7 9261.3 3443.9 3444.7 3501.4 3507.1 3531.4 1006.5 1072.6 1093.8 1156.3 1171.5 34119.3 34296.8 35012.0 35166.3 35453.5 1094.5 1158.8 1196.0 1199.1 1205.2 17993.6 17994.6 18263.7 18358.4 18400.6 645827.0 651083.0 652892.0 653960.0 655906.0 65063.0 66497.3 66910.7 67139.3 67201.7 1389.8 1405.6 1420.2 1525.0 1527.9 28704.3 34588.3 35078.3 37164.6 37722.8 63622.7 64117.7 64185.0 64211.7 64250.0 547315.0 549226.3 550328.0 550371.0 550732.0 31782.2 31897.0 32259.2 32407.2 32469.7 52806.0 52905.0 54010.2 54166.2 55816.7 44589.6 44917.3 45446.8 46292.5 46410.5 44277.6 45547.0 45679.5 45683.5 47238.5 44937.0 45384.3 45418.3 45570.0 45803.3 38119.8 39965.4 40274.8 40316.4 40834.0 30465.7 30699.8 30804.7 31205.0 31451.4 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#2] jquery.html Cycles:180 Average:28254.97 Median:3194.20 stddev:76162.50 (2384.4%) stddev-sans-first:76347.48 15:37:37 INFO - PROCESS | 3446 | Values: 421.8 422.6 437.7 438.2 439.6 19167.7 19576.8 20121.4 20217.1 20559.8 17760.2 18266.6 18606.0 19293.8 19297.5 5616.7 5768.3 5803.0 5804.5 5809.4 4283.6 4830.8 5735.0 5786.8 6347.6 6449.9 6469.4 6470.5 6480.9 6482.9 6229.5 6431.4 6439.0 6440.9 6463.8 3881.1 5299.3 5593.9 5604.1 5627.5 22622.3 23281.9 23323.2 23344.9 23536.4 2346.3 2414.5 2438.4 2469.7 2507.3 14483.6 14708.0 14970.8 15002.6 15279.6 2042.8 2060.3 2068.4 2092.5 2156.6 58153.0 67692.0 82342.0 84943.0 87069.0 10936.9 11051.2 11155.7 11576.7 11645.1 16341.1 16479.3 16485.2 16493.9 16511.3 8883.1 8972.5 9094.4 9155.4 9217.1 8572.0 8666.0 8942.8 8991.9 8992.0 6890.4 7064.3 7089.8 7112.5 7182.2 2050.9 2088.6 2126.4 2129.0 2135.1 448.5 973.0 1035.1 1048.6 1094.5 11078.6 11876.0 11975.2 11985.5 12008.6 486.7 494.5 495.4 503.5 511.6 6312.3 6313.2 6334.7 6346.6 6383.9 402264.0 407238.0 409846.0 526929.0 530097.0 89888.6 100479.5 106331.5 107572.0 109172.5 1093.6 1133.0 1152.9 1153.7 1155.5 17663.5 17749.4 17788.9 17789.1 18212.9 39439.4 40888.8 42662.8 42785.0 43784.6 58854.7 59947.7 59975.7 60263.4 61467.7 8237.9 8463.0 8478.2 8610.1 8624.0 10044.5 11731.7 12502.3 13823.7 13870.8 11472.6 11749.6 12195.6 12416.0 12450.3 11619.1 11818.2 11932.4 11953.4 12156.7 12018.2 12039.2 12058.2 12282.1 12379.7 7588.8 7968.3 8146.0 8563.1 8597.7 9048.5 12329.8 12436.4 12621.8 12621.8 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#3] mootools.html Cycles:180 Average:6233.82 Median:4833.63 stddev:3623.86 (75.0%) stddev-sans-first:3615.79 15:37:37 INFO - PROCESS | 3446 | Values: 1396.4 1540.6 1588.0 1736.3 1909.2 8966.9 9346.3 9349.0 9556.6 9562.0 9154.5 9384.4 9477.1 9479.2 9486.2 2143.8 2199.6 2209.1 2429.6 2480.8 2388.5 2461.0 2464.5 2471.8 2473.5 2374.4 2402.2 2411.7 2421.7 2424.9 2110.8 2383.6 2418.8 2452.5 2456.9 2406.5 2436.7 2436.8 2437.6 2439.6 9162.5 9267.0 9271.2 9275.6 9279.3 5377.4 5491.2 5506.9 5514.7 5520.0 3328.3 3434.9 3492.8 3518.9 3527.2 1116.7 1144.2 1146.7 1157.5 1175.9 13136.6 13165.3 13168.5 13183.8 13195.2 4781.7 4812.7 4854.6 4874.5 4917.5 11271.5 11276.3 11281.0 11300.3 11315.4 5583.7 5587.8 5588.7 5593.8 5598.8 4498.4 5051.7 5117.8 5188.9 5197.7 4176.7 4196.0 4277.9 4338.6 4344.1 1336.9 1361.7 1362.2 1364.7 1377.9 936.2 980.2 1067.5 1080.3 1090.9 6368.9 6453.4 6511.9 6532.5 6585.6 491.7 499.6 501.1 502.7 504.2 4056.2 4139.6 4247.3 4251.9 4337.2 11505.2 11982.9 12036.0 12071.2 12080.3 11661.0 11747.6 11798.6 11819.1 11855.0 8260.2 8593.3 8642.8 8789.4 8883.6 6568.7 6660.9 6769.3 6812.1 6815.8 10639.2 10921.6 10962.2 11023.2 11128.8 11205.4 11276.7 11312.1 11330.5 11331.4 7512.5 8237.2 8389.7 8440.3 8493.6 9286.6 9304.1 9344.7 9375.6 9383.1 8169.9 8382.5 8385.4 8475.8 8507.6 8211.8 8295.0 8327.0 8423.8 8433.7 7627.9 7808.1 7813.7 7820.5 7835.4 5817.3 5837.5 5936.2 5963.5 5982.6 5461.7 5577.0 5726.7 5796.9 6021.6 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#4] prototype.html Cycles:180 Average:4694.83 Median:5257.63 stddev:1353.96 (25.8%) stddev-sans-first:1317.74 15:37:37 INFO - PROCESS | 3446 | Values: 341.2 346.6 355.6 357.0 359.7 5375.4 5518.3 5584.9 5589.4 5619.0 5489.6 5504.3 5514.2 5516.9 5520.9 4322.5 4345.6 4350.7 4374.7 4391.8 4228.0 4358.8 4363.6 4375.6 4379.2 4272.2 4297.9 4301.4 4323.5 4328.8 4301.9 4321.8 4321.9 4324.4 4335.8 3670.5 3770.5 3771.3 3787.5 3791.7 5351.6 5354.6 5365.0 5372.8 5381.6 4953.6 4953.8 4965.1 4968.7 4970.2 5605.7 5791.9 5792.6 5794.4 5809.5 4168.2 4182.8 4185.4 4204.5 4217.9 5804.2 6054.0 6071.6 6074.7 6123.9 4211.5 4232.2 4255.7 4258.1 4281.8 4294.9 4299.0 4331.2 4333.3 4334.3 4857.0 4893.5 4908.5 4916.0 4959.2 5485.7 5541.3 5769.8 5780.4 5810.6 1434.4 1463.7 1469.8 1470.0 1472.8 934.8 946.4 967.0 969.0 973.0 5009.4 5027.7 5034.2 5038.8 5041.3 5246.8 5270.7 5283.7 5291.0 5306.5 4580.5 4981.3 4995.3 5002.7 5058.6 2787.8 2798.8 2815.8 2825.5 2830.5 5434.9 5439.5 5456.4 5473.3 5476.3 5101.2 5315.7 5371.8 5385.7 5386.5 5509.6 5517.5 5527.9 5536.6 5561.8 5218.6 5226.4 5252.6 5255.6 5259.6 4869.8 5180.8 5193.3 5222.9 5232.9 5384.7 5405.5 5413.8 5434.6 5459.8 3861.7 3877.3 3886.7 3894.4 3902.7 5558.9 5734.5 5754.9 6025.5 6057.5 5758.3 5793.9 5811.7 5835.9 5839.3 5793.3 5800.8 5807.5 5817.3 5819.8 5604.6 5726.1 5739.7 5740.9 5749.4 5797.6 5802.9 5820.0 5852.5 5859.7 5407.4 5676.7 5682.2 5702.3 5764.9 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - PROCESS | 3446 | [#5] yui.html Cycles:180 Average:21548.79 Median:4816.43 stddev:30541.28 (634.1%) stddev-sans-first:30587.13 15:37:37 INFO - PROCESS | 3446 | Values: 777.3 791.4 797.8 887.7 902.9 14541.6 14561.2 14596.2 15300.9 15367.8 15128.3 15190.8 15310.7 15328.8 15342.6 729.1 861.0 876.7 882.7 891.1 881.7 884.2 887.9 888.2 888.4 935.3 935.7 936.2 936.7 937.3 758.7 900.8 924.4 926.9 928.9 685.5 686.3 687.0 687.3 687.4 14420.8 14422.4 14454.2 14462.6 14495.4 14630.3 14704.8 14804.6 15028.4 15166.9 12036.0 12043.5 12119.3 14146.2 14334.4 4810.3 4822.5 4830.5 4910.6 4979.1 78911.0 81837.6 82677.2 82924.0 82975.6 11150.8 11158.7 12185.6 12341.4 12361.3 20912.4 20961.5 20970.3 20973.8 20982.7 8973.3 9167.7 9168.6 9190.7 9356.1 4854.0 4899.0 4925.5 4941.7 5063.4 3624.1 3685.6 3688.5 3712.9 3718.4 592.2 605.7 614.3 626.4 630.7 693.9 712.2 721.4 737.5 773.8 10572.4 10629.3 10687.9 10691.1 10735.7 614.8 689.6 716.9 769.5 775.7 4701.6 4833.6 4839.5 4843.9 4994.0 74369.3 114255.4 117070.7 117486.0 123514.4 102017.0 103102.0 104098.5 104730.0 105004.0 59848.7 69454.7 93727.0 94536.1 95041.0 9385.5 9410.7 9421.4 9526.9 9620.4 55714.4 56345.4 56702.4 56775.1 57571.4 73968.6 82111.0 83453.6 83737.2 84620.6 12143.8 12281.6 13139.4 14109.9 14139.4 15088.2 15701.7 15774.8 16050.0 16086.3 14498.9 14553.8 14823.1 15531.5 15856.8 14131.2 14222.8 15512.2 15688.2 15712.4 14786.8 14858.9 15094.4 15454.8 15989.9 11685.2 12266.2 12784.6 13094.3 13109.2 12830.9 13158.9 13164.5 13497.8 13569.9 15:37:37 INFO - PROCESS | 3446 | -------- Summary: end -------- 15:37:37 INFO - PROCESS | 3446 | 15:37:37 INFO - TEST-INFO | 3446: exit 0 15:37:37 INFO - TEST-OK | dromaeo_css | took 1113375ms 15:37:37 INFO - TEST-START | kraken 15:37:37 INFO - operating with platform_type : linux_ 15:37:37 INFO - Initialising browser for kraken test... 15:37:37 INFO - TEST-INFO | started process 3642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3Nzqb/profile http://localhost:40918/getInfo.html) 15:37:41 INFO - PROCESS | 3642 | __metrics Screen width/height:1600/1200 15:37:41 INFO - PROCESS | 3642 | colorDepth:24 15:37:41 INFO - PROCESS | 3642 | Browser inner width/height: 1024/697 15:37:41 INFO - PROCESS | 3642 | __metrics 15:37:42 ERROR - PROCESS | 3642 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:37:43 INFO - TEST-INFO | 3642: exit 0 15:37:43 INFO - Browser initialized. 15:37:43 INFO - Running cycle 1/1 for kraken test... 15:37:43 INFO - TEST-INFO | started process 3735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3Nzqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:55 INFO - PROCESS | 3735 | RSS: Main: 145657856 15:37:55 INFO - PROCESS | 3735 | 15:37:57 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40918/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:58 INFO - PROCESS | 3735 | RSS: Main: 194568192 15:37:58 INFO - PROCESS | 3735 | 15:38:01 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40918/tests/kraken/driver.html?testName=audio-dft) 15:38:01 INFO - PROCESS | 3735 | RSS: Main: 192212992 15:38:01 INFO - PROCESS | 3735 | 15:38:04 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40918/tests/kraken/driver.html?testName=audio-fft) 15:38:05 INFO - PROCESS | 3735 | RSS: Main: 278188032 15:38:05 INFO - PROCESS | 3735 | 15:38:07 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40918/tests/kraken/driver.html?testName=audio-oscillator) 15:38:07 INFO - PROCESS | 3735 | RSS: Main: 187633664 15:38:07 INFO - PROCESS | 3735 | 15:38:10 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:10 INFO - PROCESS | 3735 | RSS: Main: 188178432 15:38:10 INFO - PROCESS | 3735 | 15:38:13 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40918/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:14 INFO - PROCESS | 3735 | RSS: Main: 223023104 15:38:14 INFO - PROCESS | 3735 | 15:38:17 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40918/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:18 INFO - PROCESS | 3735 | RSS: Main: 221339648 15:38:18 INFO - PROCESS | 3735 | 15:38:21 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40918/tests/kraken/driver.html?testName=json-parse-financial) 15:38:21 INFO - PROCESS | 3735 | RSS: Main: 220499968 15:38:21 INFO - PROCESS | 3735 | 15:38:23 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:23 INFO - PROCESS | 3735 | RSS: Main: 199663616 15:38:23 INFO - PROCESS | 3735 | 15:38:25 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:26 INFO - PROCESS | 3735 | RSS: Main: 199254016 15:38:26 INFO - PROCESS | 3735 | 15:38:28 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:28 INFO - PROCESS | 3735 | RSS: Main: 208732160 15:38:28 INFO - PROCESS | 3735 | 15:38:31 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:31 INFO - PROCESS | 3735 | RSS: Main: 214069248 15:38:31 INFO - PROCESS | 3735 | 15:38:34 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:35 INFO - PROCESS | 3735 | RSS: Main: 216985600 15:38:35 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | Cycle 1(1): loaded http://localhost:40918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40918/tests/kraken/driver.html?testName=ai-astar) 15:38:36 INFO - PROCESS | 3735 | RSS: Main: 259022848 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | __start_tp_report 15:38:36 INFO - PROCESS | 3735 | _x_x_mozilla_page_load 15:38:36 INFO - PROCESS | 3735 | _x_x_mozilla_page_load_details 15:38:36 INFO - PROCESS | 3735 | |i|pagename|runs| 15:38:36 INFO - PROCESS | 3735 | |0;ai-astar;110;105;111;109;110;110;109;111;110;109 15:38:36 INFO - PROCESS | 3735 | |1;audio-beat-detection;162;124;126;170;131;132;158;130;178;123 15:38:36 INFO - PROCESS | 3735 | |2;audio-dft;163;161;161;161;159;159;160;164;161;160 15:38:36 INFO - PROCESS | 3735 | |3;audio-fft;75;76;75;105;75;74;73;75;101;74 15:38:36 INFO - PROCESS | 3735 | |4;audio-oscillator;84;83;118;84;84;85;124;84;85;124 15:38:36 INFO - PROCESS | 3735 | |5;imaging-gaussian-blur;116;118;117;117;117;117;116;118;117;117 15:38:36 INFO - PROCESS | 3735 | |6;imaging-darkroom;146;147;145;146;146;145;146;146;146;145 15:38:36 INFO - PROCESS | 3735 | |7;imaging-desaturate;95;95;94;94;94;95;95;95;96;94 15:38:36 INFO - PROCESS | 3735 | |8;json-parse-financial;50;50;51;50;52;52;51;51;52;52 15:38:36 INFO - PROCESS | 3735 | |9;json-stringify-tinderbox;60;59;59;59;58;59;65;59;58;61 15:38:36 INFO - PROCESS | 3735 | |10;stanford-crypto-aes;76;75;81;75;76;77;78;81;113;79 15:38:36 INFO - PROCESS | 3735 | |11;stanford-crypto-ccm;122;123;121;115;116;125;117;125;140;134 15:38:36 INFO - PROCESS | 3735 | |12;stanford-crypto-pbkdf2;152;155;155;152;151;154;156;152;154;152 15:38:36 INFO - PROCESS | 3735 | |13;stanford-crypto-sha256-iterative;61;60;65;62;61;64;64;61;60;61 15:38:36 INFO - PROCESS | 3735 | __end_tp_report 15:38:36 INFO - PROCESS | 3735 | __start_cc_report 15:38:36 INFO - PROCESS | 3735 | _x_x_mozilla_cycle_collect,1622 15:38:36 INFO - PROCESS | 3735 | __end_cc_report 15:38:36 INFO - PROCESS | 3735 | __startTimestamp1468190316900__endTimestamp 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | ------- Summary: start ------- 15:38:36 INFO - PROCESS | 3735 | Number of tests: 14 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.80 15:38:36 INFO - PROCESS | 3735 | Values: 110.0 105.0 111.0 109.0 110.0 110.0 109.0 111.0 110.0 109.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:145.00 stddev:21.14 (14.6%) stddev-sans-first:21.32 15:38:36 INFO - PROCESS | 3735 | Values: 162.0 124.0 126.0 170.0 131.0 132.0 158.0 130.0 178.0 123.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.50 15:38:36 INFO - PROCESS | 3735 | Values: 163.0 161.0 161.0 161.0 159.0 159.0 160.0 164.0 161.0 160.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:12.03 (16.0%) stddev-sans-first:12.60 15:38:36 INFO - PROCESS | 3735 | Values: 75.0 76.0 75.0 105.0 75.0 74.0 73.0 75.0 101.0 74.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.37 (21.9%) stddev-sans-first:19.01 15:38:36 INFO - PROCESS | 3735 | Values: 84.0 83.0 118.0 84.0 84.0 85.0 124.0 84.0 85.0 124.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 15:38:36 INFO - PROCESS | 3735 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:38:36 INFO - PROCESS | 3735 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:38:36 INFO - PROCESS | 3735 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 96.0 94.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:0.88 (1.7%) stddev-sans-first:0.83 15:38:36 INFO - PROCESS | 3735 | Values: 50.0 50.0 51.0 50.0 52.0 52.0 51.0 51.0 52.0 52.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:2.06 (3.5%) stddev-sans-first:2.18 15:38:36 INFO - PROCESS | 3735 | Values: 60.0 59.0 59.0 59.0 58.0 59.0 65.0 59.0 58.0 61.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.50 stddev:11.43 (14.7%) stddev-sans-first:11.97 15:38:36 INFO - PROCESS | 3735 | Values: 76.0 75.0 81.0 75.0 76.0 77.0 78.0 81.0 113.0 79.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.00 stddev:7.93 (6.4%) stddev-sans-first:8.38 15:38:36 INFO - PROCESS | 3735 | Values: 122.0 123.0 121.0 115.0 116.0 125.0 117.0 125.0 140.0 134.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:154.00 stddev:1.70 (1.1%) stddev-sans-first:1.74 15:38:36 INFO - PROCESS | 3735 | Values: 152.0 155.0 155.0 152.0 151.0 154.0 156.0 152.0 154.0 152.0 15:38:36 INFO - PROCESS | 3735 | 15:38:36 INFO - PROCESS | 3735 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:1.79 (2.9%) stddev-sans-first:1.87 15:38:36 INFO - PROCESS | 3735 | Values: 61.0 60.0 65.0 62.0 61.0 64.0 64.0 61.0 60.0 61.0 15:38:36 INFO - PROCESS | 3735 | -------- Summary: end -------- 15:38:36 INFO - PROCESS | 3735 | 15:38:39 INFO - TEST-INFO | 3735: exit 0 15:38:39 INFO - TEST-OK | kraken | took 61422ms 15:38:39 INFO - SUITE-END | took 1174s 15:38:39 INFO - Completed test suite (00:19:35) 15:38:39 INFO - javascript benchmark 15:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.883909063183, 3337.415952208363, 3367.612724536679, 3386.7629265951377, 3389.7288216942616, 5586.944130558693, 5639.2668953036155, 5665.320161580611, 5674.716264186784, 5699.658020518761, 5536.390996990328, 5590.888182236353, 5596.356419011805, 5596.636218645795, 5599.524040456556, 5037.949620503803, 5058.4435712071645, 5060.9878024395175, 5081.8221362252325, 5099.005693889674, 5068.163752980754, 5082.593392528589, 5084.084864724348, 5137.922931156036, 5174.534291913746, 5096.235564665293, 5130.204818253177, 5193.350831146106, 5204.9739751301195, 5206.921896171561, 5096.847094587169, 5119.872003199913, 5185.818496352628, 5189.714565698885, 5215.4523775003645, 4929.580985616227, 4964.05682920244, 4972.701637901738, 5010.123228435009, 5019.723915184663, 5458.890822183574, 5459.208414779874, 5476.479734425223, 5501.284832971728, 5515.283013208297, 5842.0, 5914.0, 5958.374370691102, 5960.7019649017375, 5965.463108320272, 5897.852553686149, 5913.438223368773, 5948.881022379572, 6056.204924148222, 6085.996914058, 5657.886842263173, 5686.744096515667, 5692.260006199209, 5695.7152142392715, 5696.51579615729, 6069.726862291208, 6077.787277445356, 6110.419510146529, 6189.381061893865, 6190.3190649028575, 5950.434708702666, 5960.761569537257, 5977.342492325841, 6008.909866352008, 6012.609180403348, 5957.582969192115, 5983.072623743326, 5998.190244317048, 6012.699365031731, 6029.788957386558, 5839.503642190376, 5890.14592884038, 5921.585489015728, 5945.346011938684, 5949.970250148722, 5996.220491336098, 6020.849478762978, 6034.637921724623, 6051.667158306247, 6069.969650151809, 4608.97695511527, 4621.4223222097235, 4628.3288923105965, 4629.791659375336, 4648.953510464919, 4036.2129384770274, 4071.0840060986043, 4073.490813648294, 4129.174165166918, 4151.97924010378, 5666.943330566724, 5684.175794509773, 5704.543636509069, 5705.857353566111, 5706.629069110494, 6042.758289668452, 6047.606905551125, 6051.878962420727, 6057.242844644419, 6076.635401875901, 5530.557555395559, 5623.156526520973, 5662.6036177468, 5679.488846003796, 5686.061799803069, 5202.869928251748, 5204.947950520522, 5205.947940520547, 5208.348956380452, 5230.0, 6319.24169099711, 6323.936760632427, 6327.019312006739, 6338.366163383717, 6345.270293916259, 5896.056630939029, 6007.579469437097, 6067.787627433018, 6081.118237855575, 6135.7238924249405, 6327.303996560467, 6338.492920566436, 6357.300696923242, 6364.363563643598, 6368.0, 5744.712764361849, 5978.790742323998, 5985.880282394415, 5987.0, 5999.370066143167, 5925.200097986716, 5951.672658003851, 5970.283565972111, 6014.127951446928, 6033.125196846345, 5808.854778630568, 5852.912206316823, 5854.268216472941, 5870.412958704266, 5887.646741195542, 5789.044807606698, 5805.41945805433, 5809.564282678732, 5848.912266316093, 5849.53203743708, 5752.6836024019085, 5844.883102337844, 5852.502537284208, 5855.677937713466, 5881.2942446906645, 5918.496927761016, 5941.168236446987, 5978.880422391615, 5986.700664966647, 5995.280566332068, 5677.460641239076, 5740.3685594585395, 5780.421957804186, 5810.070388737781, 5835.0], "value": 5546.649790291303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.356360476093, 647.0908373734902, 650.8600650860064, 654.2704884054278, 662.7580932959471, 33809.66190338096, 47187.528124718745, 47621.0, 47952.520474795245, 48077.519224807744, 50080.24879626808, 50670.98658026837, 50681.746591266994, 50781.49218507814, 50792.238116428285, 8323.791905202357, 9073.138051885076, 9193.080691930787, 10020.34867733595, 10242.743931401737, 10916.290441121302, 11010.944945275263, 11027.117830573576, 11028.558857645685, 11039.282446640982, 11150.330980141176, 11194.440277986108, 11198.440077996067, 11204.0, 11222.943885280562, 8469.32245420365, 10897.291676041032, 11055.281406708538, 11064.391458469781, 11462.312261264351, 10866.782664346669, 10896.782064358747, 10922.726931826688, 10924.453777311102, 10953.014228719454, 45410.0, 45648.77175614134, 45742.54257457416, 45816.312755308696, 45887.311690324335, 3661.8535258589623, 3673.1184515716304, 3841.4621952926614, 4080.0207950092063, 4270.871873843789, 34747.0, 35188.47217291743, 35394.64605353939, 35470.64529354699, 35646.643533564595, 4344.56554344563, 4351.61356158314, 4387.0, 4394.274944634131, 4465.062336909253, 358070.0, 358841.0, 358925.0, 359940.0, 360253.19873400725, 38506.61493385086, 39425.40861887017, 39434.2113157741, 67288.65422691617, 68067.65966170236, 40970.590294097274, 40988.59011409848, 41131.0, 41166.176676466304, 41343.7932810334, 14993.100413975197, 17133.742993855103, 17235.052072136154, 17256.74114888278, 17257.137143142794, 14208.64478388028, 14455.27723613815, 14476.203808790407, 14769.0, 14791.408343666348, 9175.58709858058, 9178.954105229432, 9207.86188207164, 9234.660974158844, 9261.30540209487, 3443.8622455101518, 3444.741644376682, 3501.352249833789, 3507.0881570791266, 3531.434970404723, 1006.4716024087413, 1072.6245813965206, 1093.814051611228, 1156.2946602572424, 1171.478691982077, 34119.31761364808, 34296.828515857764, 35012.0, 35166.296674066376, 35453.468197977054, 1094.5293523784849, 1158.7624536969902, 1195.964121076369, 1199.112656634102, 1205.1985429689335, 17993.64012719738, 17994.5501362467, 18263.72604410935, 18358.357457488924, 18400.63198736018, 645827.0, 651083.0, 652892.0, 653960.0, 655906.0, 65063.0, 66497.33502665008, 66910.66544667343, 67139.32860671429, 67201.66399167973, 1389.7567925612977, 1405.5713007532597, 1420.2330741399528, 1524.9847501524844, 1527.877769778415, 28704.282392940342, 34588.30823383568, 35078.29843403168, 37164.628353716114, 37722.81138594289, 63622.68188659027, 64117.67941160264, 64185.0, 64211.678941604994, 64250.0, 547315.0, 549226.2538687281, 550328.0, 550371.0, 550732.0, 31782.205444864063, 31897.044709766447, 32259.193520162185, 32407.189820254684, 32469.67530324761, 52806.0, 52905.0, 54010.18984715311, 54166.18750718821, 55816.720916395156, 44589.554104459836, 44917.32624010577, 45446.77276613728, 46292.53707463017, 46410.53589464062, 44277.55722442863, 45547.0, 45679.543204567526, 45683.54316456793, 47238.52761472341, 44937.0, 45384.319235212155, 45418.31872521849, 45570.0, 45803.3129503051, 38119.80940095282, 39965.40051899282, 40274.79175624736, 40316.3952540718, 40834.0, 30465.695343046285, 30699.846500767355, 30804.691953080182, 31205.0, 31451.370972580877], "value": 21006.856119952816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.81861799426235, 422.55420531339433, 437.7329828804429, 438.1631084628356, 439.58459256003067, 19167.712484312713, 19576.804231957674, 20121.396358109243, 20217.090230939608, 20559.794402055973, 17760.200790964405, 18266.634667306647, 18606.0, 19293.807061929376, 19297.517562060955, 5616.663000219979, 5768.336641286242, 5802.970985145068, 5804.477597016267, 5809.419058094178, 4283.614474697277, 4830.758462076899, 5735.0, 5786.768529258825, 6347.555671103025, 6449.8710025799455, 6469.35306469354, 6470.450011749007, 6480.935190648104, 6482.902756458657, 6229.4704950079295, 6431.421172094487, 6439.0, 6440.871182576346, 6463.806085817433, 3881.146147847469, 5299.258103865462, 5593.916091258634, 5604.131359639263, 5627.465390787909, 22622.321330360115, 23281.883590582107, 23323.183688570818, 23344.883275583514, 23536.411589710395, 2346.2961111666605, 2414.4929564791414, 2438.3904023994, 2469.7283298837115, 2507.260358194337, 14483.565493035227, 14708.0, 14970.775438368324, 15002.62493437662, 15279.618009549738, 2042.77529471758, 2060.268604645344, 2068.389825001628, 2092.4664210626192, 2156.579467003935, 58153.0, 67692.0, 82342.0, 84943.0, 87068.99999999936, 10936.945315273373, 11051.17116216287, 11155.665330040112, 11576.710582235342, 11645.12661550387, 16341.101239431946, 16479.34082636705, 16485.17574121313, 16493.917530412273, 16511.256993435323, 8883.067277935854, 8972.506512141896, 9094.408863423856, 9155.359124861328, 9217.124373184537, 8572.0, 8665.956670216734, 8942.776430589158, 8991.910080899239, 8991.995685759453, 6890.414314783199, 7064.258252883476, 7089.751858684921, 7112.5112421801305, 7182.174049984214, 2050.9077091530917, 2088.5614021055444, 2126.362091372613, 2128.9893550532147, 2135.135270215565, 448.4887228559445, 972.9513524323755, 1035.089121573011, 1048.6434612231878, 1094.534822700365, 11078.5568577256, 11876.0499160067, 11975.161738678209, 11985.52057917691, 12008.63974080779, 486.6860874735846, 494.5287768887531, 495.44360002571335, 503.53674619350284, 511.60095125801934, 6312.274088479791, 6313.210848643919, 6334.714937827809, 6346.619202847844, 6383.904241436382, 402264.0, 407238.0, 409846.0, 526929.0, 530097.0, 89888.5505572481, 100479.49760251152, 106331.4683426578, 107572.0, 109172.4541377304, 1093.573506332531, 1133.0425790207262, 1152.9047404965318, 1153.6712037069394, 1155.4627098399285, 17663.470095897144, 17749.378771742926, 17788.91105544464, 17789.110544472984, 18212.908935455238, 39439.408408873314, 40888.79555602203, 42662.78668606637, 42785.0, 43784.56215437805, 58854.7057264711, 59947.700261498416, 59975.70012149911, 60263.397366025776, 61467.692661538196, 8237.876431853647, 8463.0, 8478.23695867375, 8610.13898610159, 8624.0, 10044.54799534008, 11731.706707332385, 12502.312372819582, 13823.723525529233, 13870.791938120734, 11472.598459053894, 11749.647510574696, 12195.634130976085, 12416.037257067754, 12450.25298482094, 11619.128565357463, 11818.231814932002, 11932.403379830801, 11953.402329883296, 12156.696082598006, 12018.158728888893, 12039.157258992136, 12058.216215945935, 12282.140250182401, 12379.690507737017, 7588.772336829904, 7968.282854543119, 8146.0, 8563.058063612873, 8597.742067737978, 9048.50233237152, 12329.815052774036, 12436.440360183995, 12621.81067283973, 12621.810672840098], "value": 9181.570061506309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.4135063273425, 1540.5686407805815, 1587.9841201587985, 1736.3141559084163, 1909.2076788132927, 8966.86549701755, 9346.299027572943, 9348.953255233722, 9556.617735290598, 9562.043795620435, 9154.49650269235, 9384.436933783978, 9477.14705676489, 9479.241660667147, 9486.193673537757, 2143.807057364837, 2199.582079404916, 2209.0501084533644, 2429.574824405731, 2480.8015358771345, 2388.462595915914, 2460.963085553718, 2464.4578192797558, 2471.8258827057093, 2473.5423946569854, 2374.394529395002, 2402.1832576923844, 2411.686480757499, 2421.709394872618, 2424.9151279705216, 2110.7889211078923, 2383.6305372667266, 2418.7823095921362, 2452.460458699083, 2456.91400800972, 2406.470576473173, 2436.7441418650965, 2436.8416052956677, 2437.622168563875, 2439.6462512935523, 9162.541872906395, 9267.02696216901, 9271.165595096474, 9275.58259878307, 9279.257659387233, 5377.381601115882, 5491.176323551499, 5506.91739623902, 5514.696691681956, 5520.0, 3328.334333133359, 3434.939036578058, 3492.772969756983, 3518.9472157917653, 3527.224010717638, 1116.7152376144113, 1144.1876267849836, 1146.6789298996293, 1157.5196293538172, 1175.8530183727034, 13136.60590182296, 13165.341732913315, 13168.473261069546, 13183.802242966363, 13195.20828750278, 4781.713097214179, 4812.663113582085, 4854.587360074363, 4874.488178741181, 4917.5082491751255, 11271.54913803455, 11276.267042642203, 11281.0, 11300.265482743594, 11315.434228288552, 5583.748731307101, 5587.804426845041, 5588.692621905753, 5593.776248950077, 5598.832035038955, 4498.437695288089, 5051.722155281422, 5117.8464646060675, 5188.8962220755375, 5197.740112994411, 4176.665866730655, 4196.0, 4277.871663850089, 4338.58783415575, 4344.066025804467, 1336.8729970652967, 1361.6663917340315, 1362.2371471975725, 1364.6997660514671, 1377.9055835130746, 936.1855185988234, 980.1668581705493, 1067.4982758103679, 1080.303204433152, 1090.8800031996475, 6368.904466433008, 6453.386928241809, 6511.869762604816, 6532.510061745388, 6585.571937824122, 491.6976059723316, 499.62777730590216, 501.1105288113555, 502.7184776525158, 504.23104765233313, 4056.229316429869, 4139.627433530996, 4247.299195632748, 4251.87244382669, 4337.175936572041, 11505.194636375374, 11982.940085299517, 12036.037117030617, 12071.155019148751, 12080.335581542924, 11661.0, 11747.647570572897, 11798.587049453228, 11819.113566482549, 11855.0, 8260.173982601691, 8593.269572086318, 8642.827143457222, 8789.428687135316, 8883.600237989305, 6568.7372505099265, 6660.933390666225, 6769.323067693388, 6812.080369150101, 6815.795526134026, 10639.18061713631, 10921.563137474412, 10962.232643714864, 11023.17326200522, 11128.777424451304, 11205.439728013404, 11276.703179134176, 11312.095032397554, 11330.546778129112, 11331.376774277163, 7512.5492470451945, 8237.217464340878, 8389.706360277361, 8440.324774017941, 8493.57532123379, 9286.582103805209, 9304.116108969638, 9344.719658410258, 9375.578098985425, 9383.108604682544, 8169.877451838108, 8382.49705017701, 8385.37109716786, 8475.83048339042, 8507.574621269036, 8211.83576328482, 8294.958525207578, 8327.042390125212, 8423.789405264917, 8433.662653494037, 7627.8855817161675, 7808.063032436144, 7813.726519572015, 7820.491668041559, 7835.412344074103, 5817.331006934257, 5837.532997360286, 5936.228290322403, 5963.463288304073, 5982.581219314607, 5461.699606521679, 5576.972115139399, 5726.65640061581, 5796.884062318646, 6021.638701677738], "value": 4861.504210023904, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.19307836965584, 346.61179478983536, 355.5662092247458, 356.9914990152819, 359.7427839095046, 5375.387383784869, 5518.2826232589805, 5584.888302233958, 5589.357223919245, 5618.971905140474, 5489.560835133189, 5504.284443022411, 5514.200440936062, 5516.889662206753, 5520.944790552104, 4322.50291216511, 4345.587169218919, 4350.738955662655, 4374.693771436001, 4391.758453285068, 4227.978860105695, 4358.757754040099, 4363.629091527224, 4375.606195442426, 4379.189849877783, 4272.205673617088, 4297.892552686192, 4301.3547967804925, 4323.524412314643, 4328.84849030284, 4301.892452688677, 4321.762303073329, 4321.935170972438, 4324.416203812477, 4335.804888780012, 3670.4861319415304, 3770.454113813351, 3771.283456143324, 3787.450819631138, 3791.658750712449, 5351.57187425005, 5354.571634269288, 5365.0, 5372.838814835562, 5381.569474442035, 4953.628477864175, 4953.826616068421, 4965.106280869442, 4968.677035992649, 4970.204767237261, 5605.7197140142825, 5791.88416231673, 5792.565557583156, 5794.449527294901, 5809.506191973687, 4168.166366726667, 4182.811773470201, 4185.434966279544, 4204.474440694913, 4217.873463796061, 5804.21643078179, 6053.969730151321, 6071.574989750719, 6074.693940802748, 6123.87752244957, 4211.473565804275, 4232.174725928476, 4255.659547236213, 4258.1057977824385, 4281.828726850891, 4294.914101717948, 4299.011227417712, 4331.242032644274, 4333.306670932636, 4334.263175260214, 4856.975715121402, 4893.455403190321, 4908.460069392364, 4915.975420122876, 4959.156943319645, 5485.725713714299, 5541.307336582927, 5769.798057067983, 5780.439281394084, 5810.564207684441, 1434.3760464198108, 1463.6706740983193, 1469.7721853112785, 1469.9853001469849, 1472.7938088667595, 934.8177105464505, 946.3659348236698, 966.9806603867884, 969.0454901921602, 973.026973026973, 5009.398872135367, 5027.748612569357, 5034.169362055293, 5038.84883453497, 5041.319421878073, 5246.816361427332, 5270.736463176826, 5283.709395983258, 5290.973545132327, 5306.52241298285, 4580.450345958439, 4981.252812078144, 4995.325631039836, 5002.699838009731, 5058.645894787403, 2787.8466684332557, 2798.816922800219, 2815.81697189682, 2825.4914115459005, 2830.532962061278, 5434.864128396822, 5439.5104440600535, 5456.372517160577, 5473.261109750212, 5476.288082549323, 5101.20931255656, 5315.681059136464, 5371.838844834661, 5385.7307134643115, 5386.461353864583, 5509.586780991522, 5517.475839795213, 5527.861803454865, 5536.56391187876, 5561.833145005576, 5218.608604354613, 5226.372835259793, 5252.632315737862, 5255.632105752714, 5259.631825772312, 4869.829555965524, 5180.818671346485, 5193.2608521864195, 5222.9108356656125, 5232.869178270574, 5384.6615098639095, 5405.513403895128, 5413.83758487246, 5434.619576629756, 5459.808906688247, 3861.7489863158803, 3877.340852055101, 3886.7279290449396, 3894.3963685628773, 3902.726809123334, 5558.944410555842, 5734.512566431733, 5754.9424505754405, 6025.457708806229, 6057.454829065406, 5758.2725182444265, 5793.8551536211935, 5811.738471768696, 5835.912461313169, 5839.299284085937, 5793.275840519935, 5800.8259752207505, 5807.477327040587, 5817.301923769006, 5819.82540523785, 5604.551635869039, 5726.112452569859, 5739.684317362585, 5740.856478588069, 5749.396313387201, 5797.565182611237, 5802.912956305574, 5819.970900145472, 5852.50761055928, 5859.736311865891, 5407.432219617041, 5676.659400435987, 5682.181701855367, 5702.3178162441345, 5764.884702306014], "value": 4267.975130133486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.2616014785951, 791.3787676673812, 797.7925739307778, 887.6582515731443, 902.9232515236205, 14541.636459088528, 14561.199134047623, 14596.197209153492, 15300.923495382522, 15367.769483457743, 15128.319225634845, 15190.848091519081, 15310.693786124271, 15328.770068448983, 15342.616434589141, 729.0740759235767, 860.9655613775442, 876.7325965580495, 882.7219425880859, 891.1445012787732, 881.6870011146048, 884.1512148337604, 887.8756974023642, 888.2316795971502, 888.4447220487195, 935.3172184305461, 935.7099299217231, 936.204226407555, 936.66748304352, 937.3298091864316, 758.6548120605139, 900.7973206028656, 924.4268553496807, 926.8609708543738, 928.8792456980549, 685.5372623479132, 686.255412877029, 686.9690863911136, 687.3367200651395, 687.3573209049555, 14420.783688244685, 14422.350994205286, 14454.205018723966, 14462.566123016326, 14495.42018319266, 14630.26848657563, 14704.779428308584, 14804.555863324118, 15028.398864045424, 15166.924165379212, 12035.976941959943, 12043.458044387937, 12119.272843629411, 14146.151230926178, 14334.354954027094, 4810.326554282403, 4822.541858523435, 4830.541098595628, 4910.582600478963, 4979.053979743873, 78911.0, 81837.59081204615, 82677.17322826755, 82924.0, 82975.585122074, 11150.776984460266, 11158.665240042812, 12185.573504927284, 12341.3829308536, 12361.320127393079, 20912.37262882116, 20961.47596310074, 20970.266040688504, 20973.790262097184, 20982.68525972112, 8973.28213742912, 9167.724968250963, 9168.633254669738, 9190.678326258549, 9356.064393560726, 4854.0, 4898.975505122523, 4925.507449255046, 4941.654084214142, 5063.392392912874, 3624.130208749881, 3685.5577330720484, 3688.5389326334207, 3712.9443058354145, 3718.3678774608384, 592.2182718811214, 605.6517502436117, 614.2966303582373, 626.4049153304288, 630.7413960276265, 693.8889777635655, 712.2023333866103, 721.3579913876654, 737.4874462248686, 773.818152734107, 10572.36565806054, 10629.30909490896, 10687.89312106869, 10691.069800626226, 10735.731606709738, 614.797116951405, 689.5729417141961, 716.913970323554, 769.5267410542476, 775.7091090840935, 4701.576858082789, 4833.604584984979, 4839.475565196952, 4843.878903027453, 4993.950060499421, 74369.25630743623, 114255.42872285585, 117070.6585868295, 117486.0, 123514.38242808728, 102017.0, 103102.0, 104098.47950760198, 104730.0, 105004.0, 59848.70075649594, 69454.65272673705, 93727.0, 94536.10927781406, 95041.0, 9385.530723463937, 9410.670626528039, 9421.38760980534, 9526.904730952601, 9620.428907896368, 55714.442855572546, 56345.43654563402, 56702.43297567136, 56775.14837277361, 57571.424285756606, 73968.63015684887, 82111.0, 83453.58273208595, 83737.16262837537, 84620.57689711513, 12143.81784273219, 12281.631551053482, 13139.408726607135, 14109.858901410855, 14139.363728632443, 15088.24558772079, 15701.685966280382, 15774.763378549102, 16050.0, 16086.276117574504, 14498.855011450172, 14553.781693274397, 14823.110613363233, 15531.5340539784, 15856.841431585997, 14131.15213087218, 14222.786658200343, 15512.224388780742, 15688.215589220265, 15712.371505139667, 14786.778198326818, 14858.925705371405, 15094.39622415091, 15454.84545154579, 15989.920050399674, 11685.240459370114, 12266.202696824677, 12784.61646150617, 13094.345282735634, 13109.213447192817, 12830.87169128334, 13158.868411315765, 13164.47342106305, 13497.797533037208, 13569.864301357255], "value": 7983.698271944003, "unit": "score"}], "name": "dromaeo_css", "value": 7494.768946188034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 126.0, 170.0, 131.0, 132.0, 158.0, 130.0, 178.0, 123.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 159.0, 159.0, 160.0, 164.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 105.0, 75.0, 74.0, 73.0, 75.0, 101.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 84.0, 84.0, 85.0, 124.0, 84.0, 85.0, 124.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 50.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 58.0, 59.0, 65.0, 59.0, 58.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 75.0, 76.0, 77.0, 78.0, 81.0, 113.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 121.0, 115.0, 116.0, 125.0, 117.0, 125.0, 140.0, 134.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 155.0, 152.0, 151.0, 154.0, 156.0, 152.0, 154.0, 152.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 65.0, 62.0, 61.0, 64.0, 64.0, 61.0, 60.0, 61.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1477.8999999999999, "alertThreshold": 2.0}]} 15:38:39 INFO - Return code: 0 15:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:39 ERROR - # TBPL SUCCESS # 15:38:39 INFO - Running post-action listener: _resource_record_post_action 15:38:39 INFO - ##### 15:38:39 INFO - ##### Finished run-tests step (success) 15:38:39 INFO - ##### 15:38:39 INFO - Running post-run listener: _resource_record_post_run 15:38:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8044544; Write bytes: 423702528; Read time: 2188; Write time: 451468 15:38:39 INFO - TinderboxPrint: CPU usage
13.1% 15:38:39 INFO - TinderboxPrint: I/O read bytes / time
8,044,544 / 2,188 15:38:39 INFO - TinderboxPrint: I/O write bytes / time
423,702,528 / 451,468 15:38:39 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 15:38:39 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 15:38:39 INFO - TinderboxPrint: Swap in / out
0 / 0 15:38:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10485760; Read time: 0; Write time: 2644 15:38:39 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6144000; Write bytes: 343658496; Read time: 1672; Write time: 385432 15:38:40 INFO - Running post-run listener: _upload_blobber_files 15:38:40 INFO - Blob upload gear active. 15:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:40 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 15:38:40 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'] 15:38:40 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 15:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:44 INFO - (blobuploader) - INFO - Done attempting. 15:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:45 INFO - (blobuploader) - INFO - Done attempting. 15:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:46 INFO - (blobuploader) - INFO - Done attempting. 15:38:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:46 INFO - Return code: 0 15:38:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6fdd03da76b24d3cfa67857b9208f140daab1de3080edd08f42954b2830e369e456eb3758c3ca2a6d0320206cae28b0a98d03d4d2f33df8910339628fd7ac5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963cb34ddca2ad4248bea42064a27f666c4652e69c88ee4e80d5f124243ee5f4d2b10d0cdccf0ee13f6fa630425a5e0cab055bd15a061bf8553898edf6c9af51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94c9c486f6ec9e550d4b2b128b8ec781701ad13786540907e93433e86743c8d50c939fb588095d08f78beca17013133f1499c0a1e6c68ad23d4af9881061e1d8"} 15:38:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:46 INFO - Contents: 15:38:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6fdd03da76b24d3cfa67857b9208f140daab1de3080edd08f42954b2830e369e456eb3758c3ca2a6d0320206cae28b0a98d03d4d2f33df8910339628fd7ac5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963cb34ddca2ad4248bea42064a27f666c4652e69c88ee4e80d5f124243ee5f4d2b10d0cdccf0ee13f6fa630425a5e0cab055bd15a061bf8553898edf6c9af51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94c9c486f6ec9e550d4b2b128b8ec781701ad13786540907e93433e86743c8d50c939fb588095d08f78beca17013133f1499c0a1e6c68ad23d4af9881061e1d8"} 15:38:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:46 INFO - Copying logs to upload dir... 15:38:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.242891 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-10 15:38:46.145793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:46.149012) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6fdd03da76b24d3cfa67857b9208f140daab1de3080edd08f42954b2830e369e456eb3758c3ca2a6d0320206cae28b0a98d03d4d2f33df8910339628fd7ac5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963cb34ddca2ad4248bea42064a27f666c4652e69c88ee4e80d5f124243ee5f4d2b10d0cdccf0ee13f6fa630425a5e0cab055bd15a061bf8553898edf6c9af51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94c9c486f6ec9e550d4b2b128b8ec781701ad13786540907e93433e86743c8d50c939fb588095d08f78beca17013133f1499c0a1e6c68ad23d4af9881061e1d8"} build_url:https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6fdd03da76b24d3cfa67857b9208f140daab1de3080edd08f42954b2830e369e456eb3758c3ca2a6d0320206cae28b0a98d03d4d2f33df8910339628fd7ac5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/963cb34ddca2ad4248bea42064a27f666c4652e69c88ee4e80d5f124243ee5f4d2b10d0cdccf0ee13f6fa630425a5e0cab055bd15a061bf8553898edf6c9af51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94c9c486f6ec9e550d4b2b128b8ec781701ad13786540907e93433e86743c8d50c939fb588095d08f78beca17013133f1499c0a1e6c68ad23d4af9881061e1d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:46.175189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:46.175605) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468180907.402686-1337319620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:46.257897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 15:38:46.258273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 15:38:46.258654) ========= ========= Total master_lag: 0.18 =========