builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1466014972.69 results: success (0) buildid: 20160615093524 builduid: 2365f571d99047b295fa5f169de610b7 revision: e50976a962c4059618f0adcef93e49acf7264215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.688964) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.690482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.690769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.705576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.705849) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 11:22:54-- 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% 209M=0s 2016-06-15 11:22:54 (209 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.842806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.843130) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:52.893200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 11:22:52.893576) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e50976a962c4059618f0adcef93e49acf7264215 --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 e50976a962c4059618f0adcef93e49acf7264215 --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=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 11:22:54,877 truncating revision to first 12 chars 2016-06-15 11:22:54,877 Setting DEBUG logging. 2016-06-15 11:22:54,878 attempt 1/10 2016-06-15 11:22:54,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e50976a962c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 11:22:56,190 unpacking tar archive at: mozilla-aurora-e50976a962c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 11:22:54.553139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:54.553493) ========= script_repo_revision: e50976a962c4059618f0adcef93e49acf7264215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:54.553905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:54.554181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:22:54.564160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-06-15 11:22:54.564584) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:56 INFO - MultiFileLogger online at 20160615 11:22:56 in /builds/slave/test 11:22:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:22:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:56 INFO - {'append_to_log': False, 11:22:56 INFO - 'base_work_dir': '/builds/slave/test', 11:22:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:56 INFO - 'branch': 'Mozilla-Aurora', 11:22:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:56 INFO - 'config_files': ('talos/linux_config.py',), 11:22:56 INFO - 'default_actions': ('clobber', 11:22:56 INFO - 'read-buildbot-config', 11:22:56 INFO - 'download-and-extract', 11:22:56 INFO - 'populate-webroot', 11:22:56 INFO - 'create-virtualenv', 11:22:56 INFO - 'install', 11:22:56 INFO - 'run-tests'), 11:22:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:56 INFO - 'download_minidump_stackwalk': True, 11:22:56 INFO - 'download_symbols': 'ondemand', 11:22:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:56 INFO - 'installer_path': 'installer.exe', 11:22:56 INFO - 'log_level': 'info', 11:22:56 INFO - 'log_name': 'talos', 11:22:56 INFO - 'log_to_console': True, 11:22:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:56 INFO - 'opt_config_files': (), 11:22:56 INFO - 'pip_index': False, 11:22:56 INFO - 'sps_profile': False, 11:22:56 INFO - 'sps_profile_interval': 0, 11:22:56 INFO - 'suite': 'dromaeojs-e10s', 11:22:56 INFO - 'system_bits': '32', 11:22:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:56 INFO - 'title': 'talos-linux64-ix-004', 11:22:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:56 INFO - 'use_talos_json': True, 11:22:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:56 INFO - 'work_dir': 'build'} 11:22:56 INFO - ##### 11:22:56 INFO - ##### Running clobber step. 11:22:56 INFO - ##### 11:22:56 INFO - Running pre-action listener: _resource_record_pre_action 11:22:56 INFO - Running main action method: clobber 11:22:56 INFO - rmtree: /builds/slave/test/build 11:22:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:57 INFO - Running post-action listener: _resource_record_post_action 11:22:57 INFO - ##### 11:22:57 INFO - ##### Finished clobber step (success) 11:22:57 INFO - ##### 11:22:57 INFO - ##### 11:22:57 INFO - ##### Running read-buildbot-config step. 11:22:57 INFO - ##### 11:22:57 INFO - Running pre-action listener: _resource_record_pre_action 11:22:57 INFO - Running main action method: read_buildbot_config 11:22:57 INFO - Using buildbot properties: 11:22:57 INFO - { 11:22:57 INFO - "project": "", 11:22:57 INFO - "product": "firefox", 11:22:57 INFO - "script_repo_revision": "production", 11:22:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:22:57 INFO - "repository": "", 11:22:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:22:57 INFO - "buildid": "20160615093524", 11:22:57 INFO - "pgo_build": "True", 11:22:57 INFO - "basedir": "/builds/slave/test", 11:22:57 INFO - "buildnumber": 363, 11:22:57 INFO - "slavename": "talos-linux64-ix-004", 11:22:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:57 INFO - "platform": "ubuntu64_hw", 11:22:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:22:57 INFO - "branch": "mozilla-aurora", 11:22:57 INFO - "repo_path": "releases/mozilla-aurora", 11:22:57 INFO - "revision": "e50976a962c4059618f0adcef93e49acf7264215", 11:22:57 INFO - "stage_platform": "linux64-pgo", 11:22:57 INFO - "builduid": "2365f571d99047b295fa5f169de610b7", 11:22:57 INFO - "slavebuilddir": "test" 11:22:57 INFO - } 11:22:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:22:57 INFO - Running post-action listener: _resource_record_post_action 11:22:57 INFO - ##### 11:22:57 INFO - ##### Finished read-buildbot-config step (success) 11:22:57 INFO - ##### 11:22:57 INFO - ##### 11:22:57 INFO - ##### Running download-and-extract step. 11:22:57 INFO - ##### 11:22:57 INFO - Running pre-action listener: _resource_record_pre_action 11:22:57 INFO - Running main action method: download_and_extract 11:22:57 INFO - mkdir: /builds/slave/test/build/tests 11:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:57 INFO - https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:22:58 INFO - Downloaded 1361 bytes. 11:22:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:22:58 INFO - Using the following test package requirements: 11:22:58 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:58 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:58 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:22:58 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'jsshell-linux-x86_64.zip'], 11:22:58 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:58 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:58 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:58 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:58 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:58 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:58 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:58 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')]} 11:22:58 INFO - https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:08 INFO - Downloaded 24473966 bytes. 11:23:08 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'] 11:23:08 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 11:23:09 INFO - Return code: 0 11:23:09 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 11:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:09 INFO - https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:10 INFO - Downloaded 24473966 bytes. 11:23:10 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'] 11:23:10 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 11:23:12 INFO - Return code: 0 11:23:12 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')]} 11:23:12 INFO - https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:13 INFO - Downloaded 10833369 bytes. 11:23:13 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'] 11:23:13 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 11:23:13 INFO - Return code: 0 11:23:13 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')]} 11:23:13 INFO - https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YcjkUuFmRAyiUns9Q41syA/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 11:24:55 INFO - Downloaded 63571124 bytes. 11:24:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:24:55 INFO - mkdir: /builds/slave/test/properties 11:24:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:55 INFO - Contents: 11:24:55 INFO - build_url:https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:24:55 INFO - Running post-action listener: _resource_record_post_action 11:24:55 INFO - Running post-action listener: set_extra_try_arguments 11:24:55 INFO - ##### 11:24:55 INFO - ##### Finished download-and-extract step (success) 11:24:55 INFO - ##### 11:24:55 INFO - ##### 11:24:55 INFO - ##### Running populate-webroot step. 11:24:55 INFO - ##### 11:24:55 INFO - Running pre-action listener: _resource_record_pre_action 11:24:55 INFO - Running main action method: populate_webroot 11:24:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:55 INFO - '--tppagecycles', 11:24:55 INFO - '7'], 11:24:55 INFO - 'tests': ['tsvgm']}}, 11:24:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['damp', 'tps']}, 11:24:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'tests': ['damp', 'tps']}, 11:24:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['dromaeo_dom']}, 11:24:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['tsvgx', 11:24:55 INFO - 'tsvgr_opacity', 11:24:55 INFO - 'tart', 11:24:55 INFO - 'tscrollx', 11:24:55 INFO - 'cart']}, 11:24:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:55 INFO - 'tsvgr_opacity', 11:24:55 INFO - 'tart', 11:24:55 INFO - 'tscrollx', 11:24:55 INFO - 'cart']}, 11:24:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-e10s'], 11:24:55 INFO - 'tests': ['tp5o']}, 11:24:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'tests': ['tp5o']}, 11:24:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-e10s', 11:24:55 INFO - '--xperf_path', 11:24:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:55 INFO - 'tests': ['tp5n']}, 11:24:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:55 INFO - 'talos_options': ['--xperf_path', 11:24:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:55 INFO - 'tests': ['tp5n']}}, 11:24:55 INFO - 'talos.zip': {'path': '', 11:24:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:55 INFO - Running post-action listener: _resource_record_post_action 11:24:55 INFO - ##### 11:24:55 INFO - ##### Finished populate-webroot step (success) 11:24:55 INFO - ##### 11:24:55 INFO - ##### 11:24:55 INFO - ##### Running create-virtualenv step. 11:24:55 INFO - ##### 11:24:55 INFO - Running pre-action listener: _resource_record_pre_action 11:24:55 INFO - Running main action method: create_virtualenv 11:24:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:55 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 11:24:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:56 INFO - Using real prefix '/usr' 11:24:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:58 INFO - Installing pip.................done. 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:58 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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:24:58 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 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 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 11:24:58 INFO - Cleaning up... 11:24:58 INFO - Return code: 0 11:24:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:58 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')]} 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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')]} 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:58 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:24:58 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 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Downloading/unpacking psutil>=3.1.1 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:00 INFO - Installing collected packages: psutil 11:25:00 INFO - Running setup.py install for psutil 11:25:00 INFO - building 'psutil._psutil_linux' extension 11:25:00 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 11:25:01 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 11:25:01 INFO - building 'psutil._psutil_posix' extension 11:25:01 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 11:25:01 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 11:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:01 INFO - Successfully installed psutil 11:25:01 INFO - Cleaning up... 11:25:01 INFO - Return code: 0 11:25:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:01 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')]} 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 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')]} 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:01 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 11:25:01 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 11:25:01 INFO - Using env: {'DISPLAY': ':0', 11:25:01 INFO - 'HOME': '/home/cltbld', 11:25:01 INFO - 'LANG': 'en_US.UTF-8', 11:25:01 INFO - 'LANGUAGE': 'en_US:en', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MAIL': '/var/mail/cltbld', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SHLVL': '1', 11:25:01 INFO - 'TERM': 'linux', 11:25:01 INFO - 'TMOUT': '86400', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - '_': '/tools/buildbot/bin/python'} 11:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:03 INFO - Installing collected packages: mozsystemmonitor 11:25:03 INFO - Running setup.py install for mozsystemmonitor 11:25:03 INFO - Successfully installed mozsystemmonitor 11:25:03 INFO - Cleaning up... 11:25:03 INFO - Return code: 0 11:25:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:03 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:03 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 11:25:03 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 11:25:03 INFO - Using env: {'DISPLAY': ':0', 11:25:03 INFO - 'HOME': '/home/cltbld', 11:25:03 INFO - 'LANG': 'en_US.UTF-8', 11:25:03 INFO - 'LANGUAGE': 'en_US:en', 11:25:03 INFO - 'LOGNAME': 'cltbld', 11:25:03 INFO - 'MAIL': '/var/mail/cltbld', 11:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:03 INFO - 'MOZ_NO_REMOTE': '1', 11:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:03 INFO - 'NO_EM_RESTART': '1', 11:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:03 INFO - 'PWD': '/builds/slave/test', 11:25:03 INFO - 'SHELL': '/bin/bash', 11:25:03 INFO - 'SHLVL': '1', 11:25:03 INFO - 'TERM': 'linux', 11:25:03 INFO - 'TMOUT': '86400', 11:25:03 INFO - 'USER': 'cltbld', 11:25:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:03 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:03 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 11:25:03 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 11:25:03 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 11:25:03 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 11:25:03 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 11:25:03 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 11:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:06 INFO - warning: no files found matching '*.txt' 11:25:06 INFO - no previously-included directories found matching 'build' 11:25:06 INFO - no previously-included directories found matching 'dist' 11:25:06 INFO - no previously-included directories found matching '.git*' 11:25:06 INFO - Installing collected packages: jsonschema, functools32 11:25:06 INFO - Running setup.py install for functools32 11:25:06 INFO - warning: no files found matching '*.txt' 11:25:06 INFO - no previously-included directories found matching 'build' 11:25:06 INFO - no previously-included directories found matching 'dist' 11:25:06 INFO - no previously-included directories found matching '.git*' 11:25:06 INFO - Successfully installed jsonschema functools32 11:25:06 INFO - Cleaning up... 11:25:06 INFO - Return code: 0 11:25:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:06 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:06 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 11:25:06 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 11:25:06 INFO - Using env: {'DISPLAY': ':0', 11:25:06 INFO - 'HOME': '/home/cltbld', 11:25:06 INFO - 'LANG': 'en_US.UTF-8', 11:25:06 INFO - 'LANGUAGE': 'en_US:en', 11:25:06 INFO - 'LOGNAME': 'cltbld', 11:25:06 INFO - 'MAIL': '/var/mail/cltbld', 11:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:06 INFO - 'MOZ_NO_REMOTE': '1', 11:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:06 INFO - 'NO_EM_RESTART': '1', 11:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:06 INFO - 'PWD': '/builds/slave/test', 11:25:06 INFO - 'SHELL': '/bin/bash', 11:25:06 INFO - 'SHLVL': '1', 11:25:06 INFO - 'TERM': 'linux', 11:25:06 INFO - 'TMOUT': '86400', 11:25:06 INFO - 'USER': 'cltbld', 11:25:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:06 INFO - '_': '/tools/buildbot/bin/python'} 11:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:06 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 11:25:06 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 11:25:06 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 11:25:06 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 11:25:06 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 11:25:06 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 11:25:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:09 INFO - Downloading docopt-0.6.1.tar.gz 11:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:09 INFO - Running setup.py install for blobuploader 11:25:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:09 INFO - Running setup.py install for requests 11:25:09 INFO - Running setup.py install for docopt 11:25:09 INFO - Successfully installed blobuploader requests docopt 11:25:09 INFO - Cleaning up... 11:25:09 INFO - Return code: 0 11:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:09 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:09 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 11:25:09 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 11:25:09 INFO - Using env: {'DISPLAY': ':0', 11:25:09 INFO - 'HOME': '/home/cltbld', 11:25:09 INFO - 'LANG': 'en_US.UTF-8', 11:25:09 INFO - 'LANGUAGE': 'en_US:en', 11:25:09 INFO - 'LOGNAME': 'cltbld', 11:25:09 INFO - 'MAIL': '/var/mail/cltbld', 11:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:09 INFO - 'MOZ_NO_REMOTE': '1', 11:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:09 INFO - 'NO_EM_RESTART': '1', 11:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:09 INFO - 'PWD': '/builds/slave/test', 11:25:09 INFO - 'SHELL': '/bin/bash', 11:25:09 INFO - 'SHLVL': '1', 11:25:09 INFO - 'TERM': 'linux', 11:25:09 INFO - 'TMOUT': '86400', 11:25:09 INFO - 'USER': 'cltbld', 11:25:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:09 INFO - '_': '/tools/buildbot/bin/python'} 11:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:10 INFO - Running setup.py (path:/tmp/pip-zSRZzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:10 INFO - Running setup.py (path:/tmp/pip-TO_mmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:10 INFO - Running setup.py (path:/tmp/pip-ELeY8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 INFO - Running setup.py (path:/tmp/pip-jk96q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Running setup.py (path:/tmp/pip-TiBZky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Running setup.py (path:/tmp/pip-s5YVtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 INFO - Running setup.py (path:/tmp/pip-jCXEuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 INFO - Running setup.py (path:/tmp/pip-VgblSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Running setup.py (path:/tmp/pip-CBubRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:10 INFO - Running setup.py (path:/tmp/pip-Psh_WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:10 INFO - Running setup.py (path:/tmp/pip-btHexk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:10 INFO - Running setup.py (path:/tmp/pip-dD9eCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:10 INFO - Running setup.py (path:/tmp/pip-ZskQZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:11 INFO - Running setup.py (path:/tmp/pip-mTIveB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:11 INFO - Running setup.py (path:/tmp/pip-VDhQb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:11 INFO - Running setup.py (path:/tmp/pip-od2uiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:11 INFO - Running setup.py (path:/tmp/pip-9FfMbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:11 INFO - Running setup.py install for manifestparser 11:25:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozcrash 11:25:11 INFO - Running setup.py install for mozdebug 11:25:11 INFO - Running setup.py install for mozdevice 11:25:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozfile 11:25:11 INFO - Running setup.py install for mozhttpd 11:25:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozinfo 11:25:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozInstall 11:25:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozleak 11:25:12 INFO - Running setup.py install for mozlog 11:25:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for moznetwork 11:25:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozprocess 11:25:12 INFO - Running setup.py install for mozprofile 11:25:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozrunner 11:25:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozscreenshot 11:25:12 INFO - Running setup.py install for moztest 11:25:12 INFO - Running setup.py install for mozversion 11:25:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:13 INFO - Cleaning up... 11:25:13 INFO - Return code: 0 11:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:13 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')]} 11:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:13 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')]} 11:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:13 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:13 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 11:25:13 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 11:25:13 INFO - Using env: {'DISPLAY': ':0', 11:25:13 INFO - 'HOME': '/home/cltbld', 11:25:13 INFO - 'LANG': 'en_US.UTF-8', 11:25:13 INFO - 'LANGUAGE': 'en_US:en', 11:25:13 INFO - 'LOGNAME': 'cltbld', 11:25:13 INFO - 'MAIL': '/var/mail/cltbld', 11:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:13 INFO - 'MOZ_NO_REMOTE': '1', 11:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:13 INFO - 'NO_EM_RESTART': '1', 11:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:13 INFO - 'PWD': '/builds/slave/test', 11:25:13 INFO - 'SHELL': '/bin/bash', 11:25:13 INFO - 'SHLVL': '1', 11:25:13 INFO - 'TERM': 'linux', 11:25:13 INFO - 'TMOUT': '86400', 11:25:13 INFO - 'USER': 'cltbld', 11:25:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:13 INFO - '_': '/tools/buildbot/bin/python'} 11:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:13 INFO - Running setup.py (path:/tmp/pip-YJY56y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:13 INFO - Running setup.py (path:/tmp/pip-HczctP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:13 INFO - Running setup.py (path:/tmp/pip-bZNxdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:13 INFO - Running setup.py (path:/tmp/pip-95LbTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:13 INFO - Running setup.py (path:/tmp/pip-OnuPsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:13 INFO - Running setup.py (path:/tmp/pip-AnnVTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:13 INFO - Running setup.py (path:/tmp/pip-SyDKmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:13 INFO - Running setup.py (path:/tmp/pip-00sKXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:13 INFO - Running setup.py (path:/tmp/pip-XrOXl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:13 INFO - Running setup.py (path:/tmp/pip-p10dwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:14 INFO - Running setup.py (path:/tmp/pip-GAFG_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:14 INFO - Running setup.py (path:/tmp/pip-2Tj9XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:14 INFO - Running setup.py (path:/tmp/pip-36ZLtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:14 INFO - Running setup.py (path:/tmp/pip-Cy9mDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:14 INFO - Running setup.py (path:/tmp/pip-M0Ga_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:14 INFO - Running setup.py (path:/tmp/pip-IrjA0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:14 INFO - Running setup.py (path:/tmp/pip-0XzXmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:16 INFO - Downloading blessings-1.6.tar.gz 11:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:16 INFO - Installing collected packages: blessings 11:25:16 INFO - Running setup.py install for blessings 11:25:16 INFO - Successfully installed blessings 11:25:16 INFO - Cleaning up... 11:25:16 INFO - Return code: 0 11:25:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:16 INFO - Reading from file tmpfile_stdout 11:25:16 INFO - Current package versions: 11:25:16 INFO - argparse == 1.2.1 11:25:16 INFO - blessings == 1.6 11:25:16 INFO - blobuploader == 1.2.4 11:25:16 INFO - docopt == 0.6.1 11:25:16 INFO - functools32 == 3.2.3-2 11:25:16 INFO - jsonschema == 2.5.1 11:25:16 INFO - manifestparser == 1.1 11:25:16 INFO - mozInstall == 1.12 11:25:16 INFO - mozcrash == 0.17 11:25:16 INFO - mozdebug == 0.1 11:25:16 INFO - mozdevice == 0.48 11:25:16 INFO - mozfile == 1.2 11:25:16 INFO - mozhttpd == 0.7 11:25:16 INFO - mozinfo == 0.9 11:25:16 INFO - mozleak == 0.1 11:25:16 INFO - mozlog == 3.2 11:25:16 INFO - moznetwork == 0.27 11:25:16 INFO - mozprocess == 0.22 11:25:16 INFO - mozprofile == 0.28 11:25:16 INFO - mozrunner == 6.11 11:25:16 INFO - mozscreenshot == 0.1 11:25:16 INFO - mozsystemmonitor == 0.3 11:25:16 INFO - moztest == 0.7 11:25:16 INFO - mozversion == 1.4 11:25:16 INFO - psutil == 3.1.1 11:25:16 INFO - requests == 1.2.3 11:25:16 INFO - wsgiref == 0.1.2 11:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:16 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')]} 11:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:16 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')]} 11:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:16 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:16 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 11:25:16 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 11:25:16 INFO - Using env: {'DISPLAY': ':0', 11:25:16 INFO - 'HOME': '/home/cltbld', 11:25:16 INFO - 'LANG': 'en_US.UTF-8', 11:25:16 INFO - 'LANGUAGE': 'en_US:en', 11:25:16 INFO - 'LOGNAME': 'cltbld', 11:25:16 INFO - 'MAIL': '/var/mail/cltbld', 11:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:16 INFO - 'MOZ_NO_REMOTE': '1', 11:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:16 INFO - 'NO_EM_RESTART': '1', 11:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:16 INFO - 'PWD': '/builds/slave/test', 11:25:16 INFO - 'SHELL': '/bin/bash', 11:25:16 INFO - 'SHLVL': '1', 11:25:16 INFO - 'TERM': 'linux', 11:25:16 INFO - 'TMOUT': '86400', 11:25:16 INFO - 'USER': 'cltbld', 11:25:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:16 INFO - '_': '/tools/buildbot/bin/python'} 11:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 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)) 11:25:17 INFO - Cleaning up... 11:25:17 INFO - Return code: 0 11:25:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:17 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:17 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 11:25:17 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 11:25:17 INFO - Using env: {'DISPLAY': ':0', 11:25:17 INFO - 'HOME': '/home/cltbld', 11:25:17 INFO - 'LANG': 'en_US.UTF-8', 11:25:17 INFO - 'LANGUAGE': 'en_US:en', 11:25:17 INFO - 'LOGNAME': 'cltbld', 11:25:17 INFO - 'MAIL': '/var/mail/cltbld', 11:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:17 INFO - 'MOZ_NO_REMOTE': '1', 11:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:17 INFO - 'NO_EM_RESTART': '1', 11:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:17 INFO - 'PWD': '/builds/slave/test', 11:25:17 INFO - 'SHELL': '/bin/bash', 11:25:17 INFO - 'SHLVL': '1', 11:25:17 INFO - 'TERM': 'linux', 11:25:17 INFO - 'TMOUT': '86400', 11:25:17 INFO - 'USER': 'cltbld', 11:25:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:17 INFO - '_': '/tools/buildbot/bin/python'} 11:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:17 INFO - Cleaning up... 11:25:17 INFO - Return code: 0 11:25:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:17 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 0x7fb7e5286f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x293c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', '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 11:25:17 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 11:25:17 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 11:25:17 INFO - Using env: {'DISPLAY': ':0', 11:25:17 INFO - 'HOME': '/home/cltbld', 11:25:17 INFO - 'LANG': 'en_US.UTF-8', 11:25:17 INFO - 'LANGUAGE': 'en_US:en', 11:25:17 INFO - 'LOGNAME': 'cltbld', 11:25:17 INFO - 'MAIL': '/var/mail/cltbld', 11:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:17 INFO - 'MOZ_NO_REMOTE': '1', 11:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:17 INFO - 'NO_EM_RESTART': '1', 11:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:17 INFO - 'PWD': '/builds/slave/test', 11:25:17 INFO - 'SHELL': '/bin/bash', 11:25:17 INFO - 'SHLVL': '1', 11:25:17 INFO - 'TERM': 'linux', 11:25:17 INFO - 'TMOUT': '86400', 11:25:17 INFO - 'USER': 'cltbld', 11:25:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:17 INFO - '_': '/tools/buildbot/bin/python'} 11:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:17 INFO - Downloading/unpacking flake8 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:19 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 11:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:20 INFO - no previously-included directories found matching 'docs/_build' 11:25:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:20 INFO - Running setup.py install for pep8 11:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:20 INFO - no previously-included directories found matching 'docs/_build' 11:25:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:20 INFO - Cleaning up... 11:25:20 INFO - Return code: 0 11:25:20 INFO - Running post-action listener: _resource_record_post_action 11:25:20 INFO - Running post-action listener: _start_resource_monitoring 11:25:20 INFO - Starting resource monitoring. 11:25:20 INFO - ##### 11:25:20 INFO - ##### Finished create-virtualenv step (success) 11:25:20 INFO - ##### 11:25:20 INFO - ##### 11:25:20 INFO - ##### Running install step. 11:25:20 INFO - ##### 11:25:20 INFO - Running pre-action listener: _resource_record_pre_action 11:25:20 INFO - Running main action method: install 11:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:20 INFO - Reading from file tmpfile_stdout 11:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:20 INFO - Reading from file tmpfile_stdout 11:25:20 INFO - Output received: 11:25:20 INFO - Usage: mozinstall [options] installer 11:25:20 INFO - Options: 11:25:20 INFO - -h, --help show this help message and exit 11:25:20 INFO - -d DEST, --destination=DEST 11:25:20 INFO - Directory to install application into. [default: 11:25:20 INFO - "/builds/slave/test"] 11:25:20 INFO - --app=APP Application being installed. [default: firefox] 11:25:20 INFO - mkdir: /builds/slave/test/build/application 11:25:20 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'] 11:25:20 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 11:25:36 INFO - Reading from file tmpfile_stdout 11:25:36 INFO - Output received: 11:25:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:36 INFO - Running post-action listener: _resource_record_post_action 11:25:36 INFO - ##### 11:25:36 INFO - ##### Finished install step (success) 11:25:36 INFO - ##### 11:25:36 INFO - ##### 11:25:36 INFO - ##### Running run-tests step. 11:25:36 INFO - ##### 11:25:36 INFO - Running pre-action listener: _resource_record_pre_action 11:25:36 INFO - Running main action method: run_tests 11:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:36 INFO - Python 2.7.3 11:25:36 INFO - Return code: 0 11:25:36 INFO - grabbing minidump binary from tooltool 11:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:36 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 0x29cb1c0>, '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 0x29cc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:36 INFO - Return code: 0 11:25:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:37 INFO - Return code: 0 11:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:25:37 INFO - Using env: {'DISPLAY': ':0', 11:25:37 INFO - 'HOME': '/home/cltbld', 11:25:37 INFO - 'LANG': 'en_US.UTF-8', 11:25:37 INFO - 'LANGUAGE': 'en_US:en', 11:25:37 INFO - 'LOGNAME': 'cltbld', 11:25:37 INFO - 'MAIL': '/var/mail/cltbld', 11:25:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:37 INFO - 'MOZ_NO_REMOTE': '1', 11:25:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:37 INFO - 'NO_EM_RESTART': '1', 11:25:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:37 INFO - 'PWD': '/builds/slave/test', 11:25:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:37 INFO - 'SHELL': '/bin/bash', 11:25:37 INFO - 'SHLVL': '1', 11:25:37 INFO - 'TERM': 'linux', 11:25:37 INFO - 'TMOUT': '86400', 11:25:37 INFO - 'USER': 'cltbld', 11:25:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882', 11:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:37 INFO - '_': '/tools/buildbot/bin/python'} 11:25:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:25:37 INFO - mozversion application_buildid: 20160615093524 11:25:37 INFO - mozversion application_changeset: e50976a962c4059618f0adcef93e49acf7264215 11:25:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:25:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:37 INFO - mozversion application_name: Firefox 11:25:37 INFO - mozversion application_remotingname: firefox-dev 11:25:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:37 INFO - mozversion application_vendor: Mozilla 11:25:37 INFO - mozversion application_version: 49.0a2 11:25:37 INFO - mozversion platform_buildid: 20160615093524 11:25:37 INFO - mozversion platform_changeset: e50976a962c4059618f0adcef93e49acf7264215 11:25:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:37 INFO - mozversion platform_version: 49.0a2 11:25:37 INFO - using testdate: 1466015137 11:25:37 INFO - actual date: 1466015137 11:25:37 INFO - starting webserver on 'localhost:60690' 11:25:37 INFO - SUITE-START | Running 2 tests 11:25:37 INFO - TEST-START | dromaeo_css 11:25:37 INFO - operating with platform_type : linux_ 11:25:37 INFO - Initialising browser for dromaeo_css test... 11:25:37 INFO - TEST-INFO | started process 8184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3L5kYT/profile http://localhost:60690/getInfo.html) 11:25:42 INFO - PROCESS | 8184 | __metrics Screen width/height:1600/1200 11:25:42 INFO - PROCESS | 8184 | colorDepth:24 11:25:42 INFO - PROCESS | 8184 | Browser inner width/height: 1024/697 11:25:42 INFO - PROCESS | 8184 | __metrics 11:25:42 ERROR - PROCESS | 8184 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:25:43 INFO - TEST-INFO | 8184: exit 0 11:25:43 INFO - Browser initialized. 11:25:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:43 INFO - TEST-INFO | started process 8312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3L5kYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:55 INFO - PROCESS | 8312 | RSS: Main: 156086272 11:25:55 INFO - PROCESS | 8312 | 11:26:45 INFO - PROCESS | 8312 | 1466015205182 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] 11:28:53 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60690/tests/dromaeo/cssquery-ext.html) 11:28:54 INFO - PROCESS | 8312 | RSS: Main: 159285248 11:28:54 INFO - PROCESS | 8312 | 11:31:56 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-ext.html (next: http://localhost:60690/tests/dromaeo/cssquery-jquery.html) 11:31:56 INFO - PROCESS | 8312 | RSS: Main: 157814784 11:31:56 INFO - PROCESS | 8312 | 11:34:58 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60690/tests/dromaeo/cssquery-mootools.html) 11:34:59 INFO - PROCESS | 8312 | RSS: Main: 156737536 11:34:59 INFO - PROCESS | 8312 | 11:38:00 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60690/tests/dromaeo/cssquery-prototype.html) 11:38:01 INFO - PROCESS | 8312 | RSS: Main: 156823552 11:38:01 INFO - PROCESS | 8312 | 11:41:03 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60690/tests/dromaeo/cssquery-yui.html) 11:41:04 INFO - PROCESS | 8312 | RSS: Main: 158150656 11:41:04 INFO - PROCESS | 8312 | 11:44:06 INFO - PROCESS | 8312 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-yui.html (next: http://localhost:60690/tests/dromaeo/cssquery-dojo.html) 11:44:07 INFO - PROCESS | 8312 | RSS: Main: 158531584 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | __start_tp_report 11:44:07 INFO - PROCESS | 8312 | _x_x_mozilla_page_load 11:44:07 INFO - PROCESS | 8312 | _x_x_mozilla_page_load_details 11:44:07 INFO - PROCESS | 8312 | |i|pagename|runs| 11:44:07 INFO - PROCESS | 8312 | |0;dojo.html;3362.7309815214785;3365.9663403365957;3389.0849470642934;3411.8805841795543;3412.9658703412974;5611.438856114387;5649.6327738697055;5663.292088488939;5667.716614169291;5672.06410942194;5590.608657393984;5598.384177740456;5638.577106716992;5648.209250704895;5668.858278543038;5075.74621268936;5109.846704598868;5135.435102138762;5165.328507294065;5170.25031370453;5141.742912854361;5143.228515722652;5199.220116982445;5199.792008319662;5201.390756846686;5171.637985341028;5180.352455943007;5217.5565076968505;5245.055889939809;5254.316938797951;5181.637285390006;5197.168453047513;5254.605904557136;5260.105782017066;5261.763220655042;5133.6149788765615;5186.818461353834;5187.481251874782;5260.105782017066;5270.972160428718;5417.566594672417;5439.156930675752;5447.237386765856;5485.424030476823;5491.890162196773;5980.521558275327;6022.367651396584;6026.427489388501;6026.668533230671;6041.124037014608;6055.939440605625;6088.543359248074;6091.756329746805;6093.817185484399;6096.96951515244;5685.744141513601;5696.658200507983;5747.885042299173;5771;5781.8554536136935;6266.342034086447;6288.308286088527;6302.779402720883;6316.242050953915;6320.304766475684;5879.235699359141;5961.046232602763;6041.5468839837185;6064.151018857364;6064.181335519648;6049.304330002018;6149.661768602769;6167.629942203482;6172.166757487771;6179.0422484514975;6065.480412824397;6123.908141377883;6133.26400831903;6136.969315153396;6142.04798256271;5995.130706047598;6028.246469191351;6058.848528786815;6125.509959203253;6136.631802091889;4660.277656963176;4679.204535229019;4680.625549956064;4689.226277664216;4694.718316900997;4154.91690166195;4167.6457501112745;4168.687348448879;4169.520505141887;4197.4753155855515;5809.302883653989;5910.438508341701;5914.142449344821;5914.172015917775;5937.821865344046;6034.24571928509;6068.302145253264;6134.38656134383;6141.140240366352;6149.003147953866;5915.260592425947;5915.40845915405;5924.11138329254;5932.851678707981;5942.346341902387;5182.974085129626;5223.164293712987;5259.39516955555;5288.021715982555;5291.3385826771655;6293.678327551174;6365.809025729235;6370.872582548416;6385.233771947396;6392.776252831129;6046.09308603713;6187.628742275478;6201.10084037821;6208.627482351073;6233.906491402723;6209.906851397323;6235.469985051322;6257.217847769029;6319.557630965788;6354.26925903527;6002.069679199731;6011.729472173675;6014.127951446928;6031.35346443827;6079.696015199311;5922.55580831448;6102.542309326907;6109.083637454418;6119.816405507842;6126.23422072241;5958.5828991971875;6032.276126864805;6035.6076855004285;6046.27444706638;6073.089036644362;5957.702114894151;5962;6027.156198132353;6029.246344206974;6038.365971573097;5810.4189581041555;5835.708214589338;5848.561357898089;5884.676342801187;5942.584019118794;5989.580729348903;6047.727852246571;6051.485623722033;6065.5754097212775;6102.938970610237;5957.225560677084;5970.820875373745;5972.313183983723;5983.192269043623;5989.670568118621 11:44:07 INFO - PROCESS | 8312 | |1;ext.html;598.4165438697271;643.6910283064129;663.2041550139832;664.697562609013;665.0091363867836;43902.78048609757;44951.426700065465;45352.546474535244;45666.543334566646;48673;47400;47472;47821;47926.52073479264;47934.52065479344;9042.547872606376;9158.908410915905;9190.678326258583;9195.862062069074;9236.307276954221;9112.908870911306;9210.723678289662;9211.170994610484;9211.539423028855;9246.35275530713;9240.168384845363;9245.676401325954;9311.674091406801;9326.1606455419;9326.207272381856;9150.816983660356;9158.86261706075;9205.677801276923;9263.212626926686;9277.768055798626;9070.229030532413;9106.635734570675;9121.726348209564;9135.269178465707;9154.99295077541;37366.81316593427;37440.43839342412;37671.81164094162;37785.81107094474;37848.81075594632;3821.1211421372964;3864.671502922255;3988.3219852625125;4170.791460426966;4389.956100438987;33360.332793343994;33560.664393356;33944;34163.829180853936;35091.649083509095;4526.86419407415;4673.135469938073;4683.95316046842;4688.460827004904;4739.028499157665;368554;369876;373163;373785;378360.99999999726;37282.81358593189;38260.617393825705;48242.82907269181;48499.272510912364;48796;40132.398014029815;40159.397609035885;40335;40416;40422.39366409506;15620.375184992701;15746.212689365715;15764.448244311394;15845.366185352686;15880.126593037494;13209;13246.867531324757;13332.933335333455;13350.465981360638;13356.666083347995;9078.86381704275;9121.680741174026;9134;9186.770330741785;9202.079792020744;3514.1741690702665;3528;3543.94684079739;3578.9642103579154;3594.4428613564414;1039.5062345385882;1082.2370228988543;1096.2490693874563;1212.4543955220186;1283.794592865137;32810.343793124484;33071.66928330734;33213.16967075794;33218.50172247418;33431.498527522104;1150.988490115105;1165.8484397028333;1169.6198735411026;1230.2311055590255;1282.076904628666;17300;17310.480685579452;17404.216810243568;17431.825681743274;17568.94586324799;593959;638876;650238;656898;967851;63773.68113159404;63804.68097659575;64072;64304.67847660732;64487;1501.5345242974713;1516.5071351810705;1533.0035476939856;1537.3773621683013;1543.7684347347988;32981.835090824396;33533.83233083819;33698.494522582674;33841.49237761485;34414.655853441145;54852.72573637106;55809;55850.16224756713;56032;56121.15818262811;474596;474620;475597;476315;476915;30203.848980754956;30833.845830770704;30850.382992340477;31023.379532409675;31089.222769430944;51420.22869656883;52462.737686311324;52976.73511632417;53677.194842078185;54049;44313.77843110764;44471.55528444803;44730.3290450637;45298.54701452943;45525;44293.55706442894;44647.55352446434;44885.551144488134;45324;45868;43599.34600980925;44709;44804.77597611991;44813.32780008368;44948.55051449444;37885.73999100293;38108.61891381162;38395.42406863844;39260.6073939257;39747.80126099351;29301;29637.2590685226;30067.3986520264;30297.394052119274;30397 11:44:07 INFO - PROCESS | 8312 | |2;jquery.html;387.5136703437186;398.98005099745006;424.78760619690155;426.0669134595237;430.3243907065906;18817.247310107596;20496.50031724463;20865;21043.263485777963;21715.131394744192;11798.764024719521;16281.918590407031;19638.803611963875;20405.897970510163;20463.488412789688;5176.611754118447;5440.129579267318;5445.346558412976;5450.427705090968;5474.151506516497;5387.299651045359;5415.702136382497;5480.095784195603;5703.087505999041;5724.856878578048;5732.885342293152;5746.0806270996645;5764.913526297109;5789.710514474281;5826.504747096502;5917.20117784098;5932.288125424955;5958.106284057383;5962.73167707452;5978.940210597903;5047.116754567973;5342.946570534323;5368.731563421852;5762.510186634141;5778.0466223073145;14360.712785744226;14572.708545829024;14622.488212912496;23232.186873459515;24004.279871603707;2275.6586512023164;2355.823313251513;2372.1341710275797;2474.8762561871836;2598.1945596864844;10003.79992400148;10313.793724125475;11937.94031029848;14439.061461005105;15394.15332156731;2047.2220556188554;2064.4322811227034;2074;2074.968875466869;2084.9791502084936;56587.43412565863;88048.55975720144;89141.10858891394;89798.5510072452;91769.54115229448;11549.826752598718;11693.298402095901;12456.937715311366;12520.436580353724;12728.10903236783;14529.709405811824;17034.659306814043;17211.741823872653;17258.913705431394;17259.309627615006;7573.583452910033;7989.2809647132035;8055.516668999879;8266.380021498411;8268.421210515327;7545.056867891513;7620.695172193161;7624.085109786861;7700.345470634947;7953.443258971932;4677.158111539956;4692.0850434165695;4721.244600863914;4742.454617718938;5252.133397989289;2022.5044864008412;2036.7250421193246;2099.6955441460905;2146.441925099485;2167.089822274648;1006.7483129217695;1025.1491262252312;1075.295681328731;1121.4168632311153;1157.8089615213564;19641;19969.700454493195;20071.39785806428;20335.288264910658;20777.480562985744;993.9602415903428;998.0767789794411;1014.0721240065405;1016.9694909152737;1043.6921108272925;10797.46012699362;11089.83365249522;11146.665600032013;11188.384638844778;11415.143864210217;519050;543872;544803;557778;559271;100652.49673751584;101729;102045.48977255066;102871.48564257131;103744.48127759314;1048.4076496779296;1053.6522947427331;1063.2132222155703;1066.626680661762;1072.4423299884018;17534.82465175383;18053.819461805215;18234.817651823843;18348.082595869888;18565.071746412355;37132.44301335428;40645;44105.77947110244;44617.77691111524;45548.31677524774;62043.689781550805;62192.37807621866;64174;64177.358226419004;64375.67812161097;8614.396992210484;8676.002259740211;8740.694075707319;8806.691765788166;9118.498482583256;9220.815583688154;13369.465221391036;13457.327133643083;13643.931780341034;14354.49759258421;11569.132315076235;11806.822897656713;12038.75922481528;12090.274583525017;12174.695632609255;11611.129165312466;11755.294682319089;11799.941000294944;12005.339706316236;12072.698182545506;11957.701057473285;12001.339926303788;12319.199252048587;12737.74524509486;13035.543755968496;8945.552722363725;9020.819583608421;9036.412633178823;9118.179363857285;9585.376950498474;9240.445573265626;12295;12579.811302830647;12816.935915320737;12881.48474061027 11:44:07 INFO - PROCESS | 8312 | |3;mootools.html;1489.4786824611388;1518.1270769307644;1533.9539813805575;1542.2134711297235;1593.9442119525816;8078.394120440976;8659.480431174134;8691.652333906635;9363.812723745521;9370.718878433649;8898.555072246378;9084.27325813935;9109.817803643924;9169.449833010023;9223;2372.6678265042906;2414.3360575841607;2416.613341865302;2417.069428270111;2419.733829278778;2350.6944097267415;2352.882355882199;2407.2296865003204;2407.590709579367;2419.5644783938883;2340.8127349812057;2345.3433038749176;2380.631002194654;2384.4873352229356;2411.553862535428;2256.6953461282765;2284.8743319117443;2286.737025242102;2288.1533832481923;2330.557194133109;2217.4899773052125;2218.8446808723234;2221.0560511782587;2225.6550234713645;2350.7061617297836;9389.577469013911;9540;9540.379875308083;9548.761280967961;9559.283053770994;5321.201819727034;5328.600354973392;5455.509004189642;5475.753591088411;5480.424555421703;3499;3534.6111927687934;3582.5521809773777;3583.1937813991644;3636.3272794533095;1189.3696340939316;1201.0451690905752;1220.8840160184768;1228.6068458093414;1237.9504819807196;13426.731465370736;13426.86573134266;13447.529336473275;13465;13466.730665386638;4812.783424745895;4813.542713442287;4822.517748225149;4904.288878112725;4916.483769204182;11102.056325212447;11167.664970050912;11173.10615150786;11174.888251117385;11184.105271578253;5607.186957891165;5647.068233741386;5651.067573850269;5655.293088363955;5661.801836935688;4552.795124219418;4983.277424773388;5067.746612669352;5220.608454365938;5235.764390602432;4152.231837110084;4162.458880345535;4232.090100628379;4240.703150779415;4269.97520595055;1314.4216544720293;1323.1267363540017;1327.966800829987;1350.797380392949;1355.1462578575433;850.8723691446208;907.6051917415945;931.9347645664739;999.9850152095629;1036.5801850250662;6287.717052732638;6378.043293506012;6384.936150638527;6443.548951573439;6536.444402225864;974.6247694637616;976.0532283684814;991.9008099190023;1006.2201793610011;1026.584233385465;4415.955840441618;4497.168023915586;4535.4103966484145;4541.500434952152;4579.152856721451;11864.406779660982;12058.216215945935;12150.149489535825;12168.209066410654;12184.147109702413;11105.722356941142;11635.88364116348;11949.64151075469;12040.81938770919;12125.818112728317;8780.473171609723;8926.73219803407;8940.731778046538;8968.551572421353;8987.775305617412;6313.652749098844;6432.6462044588;6523.054157147282;6565.244996825235;6645.867082658223;10381.9480902595;10788.730281743019;11051.392173430539;11055.668329950115;11138.443077846237;10955;10997.725056873642;11003.394813285346;11065.834012489659;11212.943935280598;8132;8148.470349427268;8167.979002624672;8280.420370574244;8322.375821813268;9047.321450891079;9110.635574577207;9129.543522823966;9154.176124148858;9185.954070229605;8118.797030074295;8290.751277461686;8315.916840831514;8387.161283871565;8399.286060684666;7721.652525636247;7736.613169341623;7884.172161923145;8063.717769878026;8148.5518296494265;7362.3373896349585;7391.039164908528;7399.18608953004;7452.925470745223;7623;5352.116900711339;5379.838604841861;5396.676199428047;5418.241446197457;5434.3207099112615;5409.4590540947165;5451.809186678447;5473.562115030708;5511.586631002771;5608.523275521627 11:44:07 INFO - PROCESS | 8312 | |4;prototype.html;341.5542716754635;342.5427054881733;350.9104231361622;352.3516729218238;358.49452272296054;5712.343080545738;5716.742746576404;5851.678157701324;5868.970655146718;5895.204147440094;5711.371749107595;5730.79942202023;5757;5769.596128271022;5785.537157027427;4264.23243816113;4461.263891457906;4489.618382437497;4494.8202071917085;4534.727916325014;4408.5591440855815;4420.447444069491;4433.359656926926;4457.24226881431;4469.340742258351;4398.98823270648;4419.160359531695;4427.89674904421;4439.600435960763;4446.822127114911;4438.800253988578;4447.353824474432;4449.310356894686;4456.844010459618;4488.236999710057;3730.9626903730887;3891.3579259422163;3896.220755848813;3924.2347742190286;3933.449317095609;5508.807191748269;5543.168524721284;5550.639208451478;5585.4919171823785;5590.580706447033;5105.361829771278;5115.641905066647;5145.665531740425;5149.201873709581;5185.688858668492;5753.395893431171;6040.516758659297;6040.607360521596;6040.969795150996;6076.361981991871;4283.700140990132;4292.120115376371;4297.226499230137;4302.290122129845;4327.221100201962;5605.69698218955;6151.231096113031;6241.906371404432;6330.335314791927;6355.936440635581;4325.1565944641125;4340.782960852008;4358.651307895424;4365.716228445141;4370.475542934868;4400.393856242513;4409.603135717801;4411.911761764811;4433.423654924839;4446.26636604963;5010.398752149766;5044.394672639307;5080.390353157571;5094.133997220481;5109.901371205208;5952.791652292149;5995.790147344822;6012.669303188367;6022.759089636453;6036.426539478743;1500.7823865539654;1528.7248295306729;1535.7005383950245;1539.568920702205;1541.2216830500524;942.8821397325335;974.4104816586005;978.8042391521582;982.8378317577663;986.5461887531673;5238.607104467104;5250.317458730417;5270.235815806686;5274.3385833462335;5328.387235467893;5453.454654534515;5529.474699903583;5535.501804837584;5538.363088244822;5550.58370622205;4988.7505624718615;5268.420473747885;5295.417504074626;5298.708571028554;5372.301600791872;2973.4945059339966;2996.325826689021;2996.4905965985836;3009.3981203759336;3018.471767440733;5533;5666.979943610189;5764.971175144097;5771.85570360736;5779.8555036124435;5550.250716153349;5575.972120139373;5628.242161340995;5652.717364131777;5659;5657.321121465368;6251.343608921089;6488.188976377953;6540.509461790385;6580.309067547839;6318.241810982711;6326.620402775849;6343.55595108338;6356.713947872265;6380.680965951777;6018.2778066630535;6187.906046976512;6240.968795155995;6263.34021484298;6297.1813664223355;6429.9678501607195;6519.706613202512;6537.803865884031;6553.475721942138;6581.078648989241;4408.58118478744;4418.100216906761;4424.579664931826;4431.7340959542535;4446.933296000628;5956.493698035542;6278.529110316836;6285.182926219562;6344.9048264277;6386.361363863576;6121.84695382619;6200.937990620036;6202.968985155226;6212.689365531615;6221.222347206599;5960.672163030901;6066.059760737093;6080.90878636812;6134.938650613615;6232.594881332699;6011.549133815069;6014.097885317237;6039.275286965592;6062.363451837494;6089.421504957022;5944.524438045032;6184.907226391698;6186.1030150627;6200.81397558074;6227.719752611053;6022.668753218615;6062.242219722535;6097.695115244132;6099.566601848651;6150.723217455135 11:44:07 INFO - PROCESS | 8312 | |5;yui.html;732.3116270705536;758.5107605594395;791.7743443118712;874.7463235661658;916.2120576304379;16111.35554577817;16504.257308421118;17034.148292585367;17213.741793873072;17553.736693949602;16294.185290735446;16484.505464836075;16530.42143524977;16533.58666033347;16584.585385365343;871.995640021799;873.083262574296;895.740235331753;901.0673952459206;903.4398672822826;899.7390756680587;902.3187493442442;906.4697152165991;907.591583787295;912.5756523216703;944.8204841080172;946.9905300946971;953.6614501851847;953.8378475659119;954.5179684259474;935.4153653966305;943.7829299261208;947.3463310315894;950.4772375193651;950.8589692369185;694.6804469943831;696.7526528082559;696.7839969609437;696.9686364113627;698.5075521757149;15588.92205538965;15631;15676.137812420313;15679.372825086983;15757;14921.179335136563;15038.248087595577;15047;15083.47207847731;15138.772918406232;12525.311107889063;12660.430280637393;12775.29735864527;12790.808137877939;12917;4051.6424904042847;4082.632563069338;4110.05468742191;4154.688398370135;4176.644985176264;84539.5773021131;85984;87877.56061219652;88120.55939720325;89997;12409.93795031019;12426.56507022268;12480.251184928751;12486.937565312297;12656;22854.17166626666;22857;22973.195938142086;22999.770002300098;23042;8852.203301702877;8935.419197752126;8986;9076.81846363069;9226.30802689801;5057.241413787961;5247.2653828464045;5281.551068159172;5308.575313974873;5408.91886621701;3392.796432214075;3509.4911237870874;3520.8415621297104;3975.0857302820514;4137.110521237948;681.0533358631507;684.0662495693343;695.4679670052413;696.5890124826276;704.3907020427396;694.5624256718235;698.6227437183863;761.2805898425935;789.9368050555942;802.2338666573409;10103;10227.28409011362;10347.586096556204;10404.947975260075;10423.166146708245;642.3287664390723;753.4273951796674;826.0706704956923;853.1766844994486;873.5588527793424;4925.630577706686;5147.503460821498;5193.065248255275;5260.2109683547005;5394.541463975527;75543;91986;118326.40836795761;119220.40389797995;121632;103747;107346.75802222133;107431;108288;108405;93604.0639593609;94199.52900235592;94817;95131.52434237784;96026;10162.136218421518;10221.693349199535;10335.22485813582;10368.222383321432;10407.063364296946;48198.759006204746;52919.99999999846;53367;53743.731281343345;54237;68933.65533172301;72279;78674;79308.20691793009;80212;13277.468901244229;14253.287335633384;14319.427222910967;14485.782713259521;14561.708765824837;15524;15663.765043524128;15737.842621574096;16258.674826503167;16750.246238919033;14387.784183237469;14443.49447769323;15258.465953692012;15390.769138462709;15429.84570154329;14724.779128313297;15435.536933892;15574;15855.68288634244;15868.76196857025;14706.63233419173;14950.028248163835;15586.844131558993;15640.139792311076;15763.763543547086;11790;12172.33052182103;12215.511379544718;12372.1958072725;12823.679408014874;11690.240134391237;12271.57049503263;12284.201526900722;12332.383380830743;12848.486060557472 11:44:07 INFO - PROCESS | 8312 | __end_tp_report 11:44:07 INFO - PROCESS | 8312 | __start_cc_report 11:44:07 INFO - PROCESS | 8312 | _x_x_mozilla_cycle_collect,323 11:44:07 INFO - PROCESS | 8312 | __end_cc_report 11:44:07 INFO - PROCESS | 8312 | __startTimestamp1466016247191__endTimestamp 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | ------- Summary: start ------- 11:44:07 INFO - PROCESS | 8312 | Number of tests: 6 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#0] dojo.html Cycles:165 Average:5679.74 Median:5957.23 stddev:640.50 (10.8%) stddev-sans-first:616.14 11:44:07 INFO - PROCESS | 8312 | Values: 3362.7 3366.0 3389.1 3411.9 3413.0 5611.4 5649.6 5663.3 5667.7 5672.1 5590.6 5598.4 5638.6 5648.2 5668.9 5075.7 5109.8 5135.4 5165.3 5170.3 5141.7 5143.2 5199.2 5199.8 5201.4 5171.6 5180.4 5217.6 5245.1 5254.3 5181.6 5197.2 5254.6 5260.1 5261.8 5133.6 5186.8 5187.5 5260.1 5271.0 5417.6 5439.2 5447.2 5485.4 5491.9 5980.5 6022.4 6026.4 6026.7 6041.1 6055.9 6088.5 6091.8 6093.8 6097.0 5685.7 5696.7 5747.9 5771.0 5781.9 6266.3 6288.3 6302.8 6316.2 6320.3 5879.2 5961.0 6041.5 6064.2 6064.2 6049.3 6149.7 6167.6 6172.2 6179.0 6065.5 6123.9 6133.3 6137.0 6142.0 5995.1 6028.2 6058.8 6125.5 6136.6 4660.3 4679.2 4680.6 4689.2 4694.7 4154.9 4167.6 4168.7 4169.5 4197.5 5809.3 5910.4 5914.1 5914.2 5937.8 6034.2 6068.3 6134.4 6141.1 6149.0 5915.3 5915.4 5924.1 5932.9 5942.3 5183.0 5223.2 5259.4 5288.0 5291.3 6293.7 6365.8 6370.9 6385.2 6392.8 6046.1 6187.6 6201.1 6208.6 6233.9 6209.9 6235.5 6257.2 6319.6 6354.3 6002.1 6011.7 6014.1 6031.4 6079.7 5922.6 6102.5 6109.1 6119.8 6126.2 5958.6 6032.3 6035.6 6046.3 6073.1 5957.7 5962.0 6027.2 6029.2 6038.4 5810.4 5835.7 5848.6 5884.7 5942.6 5989.6 6047.7 6051.5 6065.6 6102.9 5957.2 5970.8 5972.3 5983.2 5989.7 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#1] ext.html Cycles:180 Average:66425.64 Median:44392.67 stddev:144756.66 (326.1%) stddev-sans-first:145078.36 11:44:07 INFO - PROCESS | 8312 | Values: 598.4 643.7 663.2 664.7 665.0 43902.8 44951.4 45352.5 45666.5 48673.0 47400.0 47472.0 47821.0 47926.5 47934.5 9042.5 9158.9 9190.7 9195.9 9236.3 9112.9 9210.7 9211.2 9211.5 9246.4 9240.2 9245.7 9311.7 9326.2 9326.2 9150.8 9158.9 9205.7 9263.2 9277.8 9070.2 9106.6 9121.7 9135.3 9155.0 37366.8 37440.4 37671.8 37785.8 37848.8 3821.1 3864.7 3988.3 4170.8 4390.0 33360.3 33560.7 33944.0 34163.8 35091.6 4526.9 4673.1 4684.0 4688.5 4739.0 368554.0 369876.0 373163.0 373785.0 378361.0 37282.8 38260.6 48242.8 48499.3 48796.0 40132.4 40159.4 40335.0 40416.0 40422.4 15620.4 15746.2 15764.4 15845.4 15880.1 13209.0 13246.9 13332.9 13350.5 13356.7 9078.9 9121.7 9134.0 9186.8 9202.1 3514.2 3528.0 3543.9 3579.0 3594.4 1039.5 1082.2 1096.2 1212.5 1283.8 32810.3 33071.7 33213.2 33218.5 33431.5 1151.0 1165.8 1169.6 1230.2 1282.1 17300.0 17310.5 17404.2 17431.8 17568.9 593959.0 638876.0 650238.0 656898.0 967851.0 63773.7 63804.7 64072.0 64304.7 64487.0 1501.5 1516.5 1533.0 1537.4 1543.8 32981.8 33533.8 33698.5 33841.5 34414.7 54852.7 55809.0 55850.2 56032.0 56121.2 474596.0 474620.0 475597.0 476315.0 476915.0 30203.8 30833.8 30850.4 31023.4 31089.2 51420.2 52462.7 52976.7 53677.2 54049.0 44313.8 44471.6 44730.3 45298.5 45525.0 44293.6 44647.6 44885.6 45324.0 45868.0 43599.3 44709.0 44804.8 44813.3 44948.6 37885.7 38108.6 38395.4 39260.6 39747.8 29301.0 29637.3 30067.4 30297.4 30397.0 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#2] jquery.html Cycles:180 Average:31136.11 Median:11594.85 stddev:89912.46 (775.5%) stddev-sans-first:90135.04 11:44:07 INFO - PROCESS | 8312 | Values: 387.5 399.0 424.8 426.1 430.3 18817.2 20496.5 20865.0 21043.3 21715.1 11798.8 16281.9 19638.8 20405.9 20463.5 5176.6 5440.1 5445.3 5450.4 5474.2 5387.3 5415.7 5480.1 5703.1 5724.9 5732.9 5746.1 5764.9 5789.7 5826.5 5917.2 5932.3 5958.1 5962.7 5978.9 5047.1 5342.9 5368.7 5762.5 5778.0 14360.7 14572.7 14622.5 23232.2 24004.3 2275.7 2355.8 2372.1 2474.9 2598.2 10003.8 10313.8 11937.9 14439.1 15394.2 2047.2 2064.4 2074.0 2075.0 2085.0 56587.4 88048.6 89141.1 89798.6 91769.5 11549.8 11693.3 12456.9 12520.4 12728.1 14529.7 17034.7 17211.7 17258.9 17259.3 7573.6 7989.3 8055.5 8266.4 8268.4 7545.1 7620.7 7624.1 7700.3 7953.4 4677.2 4692.1 4721.2 4742.5 5252.1 2022.5 2036.7 2099.7 2146.4 2167.1 1006.7 1025.1 1075.3 1121.4 1157.8 19641.0 19969.7 20071.4 20335.3 20777.5 994.0 998.1 1014.1 1017.0 1043.7 10797.5 11089.8 11146.7 11188.4 11415.1 519050.0 543872.0 544803.0 557778.0 559271.0 100652.5 101729.0 102045.5 102871.5 103744.5 1048.4 1053.7 1063.2 1066.6 1072.4 17534.8 18053.8 18234.8 18348.1 18565.1 37132.4 40645.0 44105.8 44617.8 45548.3 62043.7 62192.4 64174.0 64177.4 64375.7 8614.4 8676.0 8740.7 8806.7 9118.5 9220.8 13369.5 13457.3 13643.9 14354.5 11569.1 11806.8 12038.8 12090.3 12174.7 11611.1 11755.3 11799.9 12005.3 12072.7 11957.7 12001.3 12319.2 12737.7 13035.5 8945.6 9020.8 9036.4 9118.2 9585.4 9240.4 12295.0 12579.8 12816.9 12881.5 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#3] mootools.html Cycles:180 Average:6180.27 Median:4818.03 stddev:3595.14 (74.6%) stddev-sans-first:3587.94 11:44:07 INFO - PROCESS | 8312 | Values: 1489.5 1518.1 1534.0 1542.2 1593.9 8078.4 8659.5 8691.7 9363.8 9370.7 8898.6 9084.3 9109.8 9169.4 9223.0 2372.7 2414.3 2416.6 2417.1 2419.7 2350.7 2352.9 2407.2 2407.6 2419.6 2340.8 2345.3 2380.6 2384.5 2411.6 2256.7 2284.9 2286.7 2288.2 2330.6 2217.5 2218.8 2221.1 2225.7 2350.7 9389.6 9540.0 9540.4 9548.8 9559.3 5321.2 5328.6 5455.5 5475.8 5480.4 3499.0 3534.6 3582.6 3583.2 3636.3 1189.4 1201.0 1220.9 1228.6 1238.0 13426.7 13426.9 13447.5 13465.0 13466.7 4812.8 4813.5 4822.5 4904.3 4916.5 11102.1 11167.7 11173.1 11174.9 11184.1 5607.2 5647.1 5651.1 5655.3 5661.8 4552.8 4983.3 5067.7 5220.6 5235.8 4152.2 4162.5 4232.1 4240.7 4270.0 1314.4 1323.1 1328.0 1350.8 1355.1 850.9 907.6 931.9 1000.0 1036.6 6287.7 6378.0 6384.9 6443.5 6536.4 974.6 976.1 991.9 1006.2 1026.6 4416.0 4497.2 4535.4 4541.5 4579.2 11864.4 12058.2 12150.1 12168.2 12184.1 11105.7 11635.9 11949.6 12040.8 12125.8 8780.5 8926.7 8940.7 8968.6 8987.8 6313.7 6432.6 6523.1 6565.2 6645.9 10381.9 10788.7 11051.4 11055.7 11138.4 10955.0 10997.7 11003.4 11065.8 11212.9 8132.0 8148.5 8168.0 8280.4 8322.4 9047.3 9110.6 9129.5 9154.2 9186.0 8118.8 8290.8 8315.9 8387.2 8399.3 7721.7 7736.6 7884.2 8063.7 8148.6 7362.3 7391.0 7399.2 7452.9 7623.0 5352.1 5379.8 5396.7 5418.2 5434.3 5409.5 5451.8 5473.6 5511.6 5608.5 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#4] prototype.html Cycles:180 Average:4999.86 Median:5580.73 stddev:1489.85 (26.7%) stddev-sans-first:1452.43 11:44:07 INFO - PROCESS | 8312 | Values: 341.6 342.5 350.9 352.4 358.5 5712.3 5716.7 5851.7 5869.0 5895.2 5711.4 5730.8 5757.0 5769.6 5785.5 4264.2 4461.3 4489.6 4494.8 4534.7 4408.6 4420.4 4433.4 4457.2 4469.3 4399.0 4419.2 4427.9 4439.6 4446.8 4438.8 4447.4 4449.3 4456.8 4488.2 3731.0 3891.4 3896.2 3924.2 3933.4 5508.8 5543.2 5550.6 5585.5 5590.6 5105.4 5115.6 5145.7 5149.2 5185.7 5753.4 6040.5 6040.6 6041.0 6076.4 4283.7 4292.1 4297.2 4302.3 4327.2 5605.7 6151.2 6241.9 6330.3 6355.9 4325.2 4340.8 4358.7 4365.7 4370.5 4400.4 4409.6 4411.9 4433.4 4446.3 5010.4 5044.4 5080.4 5094.1 5109.9 5952.8 5995.8 6012.7 6022.8 6036.4 1500.8 1528.7 1535.7 1539.6 1541.2 942.9 974.4 978.8 982.8 986.5 5238.6 5250.3 5270.2 5274.3 5328.4 5453.5 5529.5 5535.5 5538.4 5550.6 4988.8 5268.4 5295.4 5298.7 5372.3 2973.5 2996.3 2996.5 3009.4 3018.5 5533.0 5667.0 5765.0 5771.9 5779.9 5550.3 5576.0 5628.2 5652.7 5659.0 5657.3 6251.3 6488.2 6540.5 6580.3 6318.2 6326.6 6343.6 6356.7 6380.7 6018.3 6187.9 6241.0 6263.3 6297.2 6430.0 6519.7 6537.8 6553.5 6581.1 4408.6 4418.1 4424.6 4431.7 4446.9 5956.5 6278.5 6285.2 6344.9 6386.4 6121.8 6200.9 6203.0 6212.7 6221.2 5960.7 6066.1 6080.9 6134.9 6232.6 6011.5 6014.1 6039.3 6062.4 6089.4 5944.5 6184.9 6186.1 6200.8 6227.7 6022.7 6062.2 6097.7 6099.6 6150.7 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - PROCESS | 8312 | [#5] yui.html Cycles:180 Average:21969.93 Median:3747.96 stddev:30989.68 (826.8%) stddev-sans-first:31035.59 11:44:07 INFO - PROCESS | 8312 | Values: 732.3 758.5 791.8 874.7 916.2 16111.4 16504.3 17034.1 17213.7 17553.7 16294.2 16484.5 16530.4 16533.6 16584.6 872.0 873.1 895.7 901.1 903.4 899.7 902.3 906.5 907.6 912.6 944.8 947.0 953.7 953.8 954.5 935.4 943.8 947.3 950.5 950.9 694.7 696.8 696.8 697.0 698.5 15588.9 15631.0 15676.1 15679.4 15757.0 14921.2 15038.2 15047.0 15083.5 15138.8 12525.3 12660.4 12775.3 12790.8 12917.0 4051.6 4082.6 4110.1 4154.7 4176.6 84539.6 85984.0 87877.6 88120.6 89997.0 12409.9 12426.6 12480.3 12486.9 12656.0 22854.2 22857.0 22973.2 22999.8 23042.0 8852.2 8935.4 8986.0 9076.8 9226.3 5057.2 5247.3 5281.6 5308.6 5408.9 3392.8 3509.5 3520.8 3975.1 4137.1 681.1 684.1 695.5 696.6 704.4 694.6 698.6 761.3 789.9 802.2 10103.0 10227.3 10347.6 10404.9 10423.2 642.3 753.4 826.1 853.2 873.6 4925.6 5147.5 5193.1 5260.2 5394.5 75543.0 91986.0 118326.4 119220.4 121632.0 103747.0 107346.8 107431.0 108288.0 108405.0 93604.1 94199.5 94817.0 95131.5 96026.0 10162.1 10221.7 10335.2 10368.2 10407.1 48198.8 52920.0 53367.0 53743.7 54237.0 68933.7 72279.0 78674.0 79308.2 80212.0 13277.5 14253.3 14319.4 14485.8 14561.7 15524.0 15663.8 15737.8 16258.7 16750.2 14387.8 14443.5 15258.5 15390.8 15429.8 14724.8 15435.5 15574.0 15855.7 15868.8 14706.6 14950.0 15586.8 15640.1 15763.8 11790.0 12172.3 12215.5 12372.2 12823.7 11690.2 12271.6 12284.2 12332.4 12848.5 11:44:07 INFO - PROCESS | 8312 | -------- Summary: end -------- 11:44:07 INFO - PROCESS | 8312 | 11:44:07 INFO - TEST-INFO | 8312: exit 0 11:44:07 INFO - TEST-OK | dromaeo_css | took 1110115ms 11:44:07 INFO - TEST-START | kraken 11:44:07 INFO - operating with platform_type : linux_ 11:44:07 INFO - Initialising browser for kraken test... 11:44:07 INFO - TEST-INFO | started process 8559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhh5m2/profile http://localhost:60690/getInfo.html) 11:44:12 INFO - PROCESS | 8559 | __metrics Screen width/height:1600/1200 11:44:12 INFO - PROCESS | 8559 | colorDepth:24 11:44:12 INFO - PROCESS | 8559 | Browser inner width/height: 1024/697 11:44:12 INFO - PROCESS | 8559 | __metrics 11:44:13 ERROR - PROCESS | 8559 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:44:14 INFO - TEST-INFO | 8559: exit 0 11:44:14 INFO - Browser initialized. 11:44:14 INFO - Running cycle 1/1 for kraken test... 11:44:14 INFO - TEST-INFO | started process 8693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhh5m2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:25 INFO - PROCESS | 8693 | RSS: Main: 156213248 11:44:25 INFO - PROCESS | 8693 | 11:44:28 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:29 INFO - PROCESS | 8693 | RSS: Main: 161288192 11:44:29 INFO - PROCESS | 8693 | 11:44:31 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-dft) 11:44:32 INFO - PROCESS | 8693 | RSS: Main: 160882688 11:44:32 INFO - PROCESS | 8693 | 11:44:35 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-fft) 11:44:36 INFO - PROCESS | 8693 | RSS: Main: 161894400 11:44:36 INFO - PROCESS | 8693 | 11:44:38 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-oscillator) 11:44:38 INFO - PROCESS | 8693 | RSS: Main: 161546240 11:44:38 INFO - PROCESS | 8693 | 11:44:40 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:41 INFO - PROCESS | 8693 | RSS: Main: 161210368 11:44:41 INFO - PROCESS | 8693 | 11:44:44 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:45 INFO - PROCESS | 8693 | RSS: Main: 160538624 11:44:45 INFO - PROCESS | 8693 | 11:44:48 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:49 INFO - PROCESS | 8693 | RSS: Main: 157589504 11:44:49 INFO - PROCESS | 8693 | 11:44:52 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60690/tests/kraken/driver.html?testName=json-parse-financial) 11:44:52 INFO - PROCESS | 8693 | RSS: Main: 159571968 11:44:52 INFO - PROCESS | 8693 | 11:44:54 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:54 INFO - PROCESS | 8693 | RSS: Main: 159997952 11:44:54 INFO - PROCESS | 8693 | 11:44:56 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:57 INFO - PROCESS | 8693 | RSS: Main: 159756288 11:44:57 INFO - PROCESS | 8693 | 11:44:59 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:00 INFO - PROCESS | 8693 | RSS: Main: 159879168 11:45:00 INFO - PROCESS | 8693 | 11:45:02 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:03 INFO - PROCESS | 8693 | RSS: Main: 160571392 11:45:03 INFO - PROCESS | 8693 | 11:45:05 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:06 INFO - PROCESS | 8693 | RSS: Main: 160358400 11:45:06 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60690/tests/kraken/driver.html?testName=ai-astar) 11:45:08 INFO - PROCESS | 8693 | RSS: Main: 160518144 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | __start_tp_report 11:45:08 INFO - PROCESS | 8693 | _x_x_mozilla_page_load 11:45:08 INFO - PROCESS | 8693 | _x_x_mozilla_page_load_details 11:45:08 INFO - PROCESS | 8693 | |i|pagename|runs| 11:45:08 INFO - PROCESS | 8693 | |0;ai-astar;111;106;110;111;111;112;113;112;111;110 11:45:08 INFO - PROCESS | 8693 | |1;audio-beat-detection;173;128;153;173;127;161;150;135;188;136 11:45:08 INFO - PROCESS | 8693 | |2;audio-dft;164;165;167;163;163;162;163;164;165;162 11:45:08 INFO - PROCESS | 8693 | |3;audio-fft;76;75;75;171;77;75;75;76;176;78 11:45:08 INFO - PROCESS | 8693 | |4;audio-oscillator;86;85;152;85;85;86;145;84;84;147 11:45:08 INFO - PROCESS | 8693 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;118;117 11:45:08 INFO - PROCESS | 8693 | |6;imaging-darkroom;149;149;149;149;150;151;149;150;149;146 11:45:08 INFO - PROCESS | 8693 | |7;imaging-desaturate;95;97;100;96;96;101;101;95;95;95 11:45:08 INFO - PROCESS | 8693 | |8;json-parse-financial;53;53;57;53;53;56;54;54;54;54 11:45:08 INFO - PROCESS | 8693 | |9;json-stringify-tinderbox;59;60;61;60;60;62;60;59;60;61 11:45:08 INFO - PROCESS | 8693 | |10;stanford-crypto-aes;78;78;79;80;78;79;79;79;104;78 11:45:08 INFO - PROCESS | 8693 | |11;stanford-crypto-ccm;124;132;128;121;134;127;133;130;127;121 11:45:08 INFO - PROCESS | 8693 | |12;stanford-crypto-pbkdf2;156;155;156;157;159;155;159;160;157;162 11:45:08 INFO - PROCESS | 8693 | |13;stanford-crypto-sha256-iterative;66;66;62;62;62;64;62;62;62;61 11:45:08 INFO - PROCESS | 8693 | __end_tp_report 11:45:08 INFO - PROCESS | 8693 | __start_cc_report 11:45:08 INFO - PROCESS | 8693 | _x_x_mozilla_cycle_collect,868 11:45:08 INFO - PROCESS | 8693 | __end_cc_report 11:45:08 INFO - PROCESS | 8693 | __startTimestamp1466016308431__endTimestamp 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | ------- Summary: start ------- 11:45:08 INFO - PROCESS | 8693 | Number of tests: 14 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 11:45:08 INFO - PROCESS | 8693 | Values: 111.0 106.0 110.0 111.0 111.0 112.0 113.0 112.0 111.0 110.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.00 stddev:21.10 (13.4%) stddev-sans-first:21.03 11:45:08 INFO - PROCESS | 8693 | Values: 173.0 128.0 153.0 173.0 127.0 161.0 150.0 135.0 188.0 136.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 11:45:08 INFO - PROCESS | 8693 | Values: 164.0 165.0 167.0 163.0 163.0 162.0 163.0 164.0 165.0 162.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.19 (54.6%) stddev-sans-first:43.09 11:45:08 INFO - PROCESS | 8693 | Values: 76.0 75.0 75.0 171.0 77.0 75.0 75.0 76.0 176.0 78.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:30.49 (35.9%) stddev-sans-first:31.64 11:45:08 INFO - PROCESS | 8693 | Values: 86.0 85.0 152.0 85.0 85.0 86.0 145.0 84.0 84.0 147.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:45:08 INFO - PROCESS | 8693 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 11:45:08 INFO - PROCESS | 8693 | Values: 149.0 149.0 149.0 149.0 150.0 151.0 149.0 150.0 149.0 146.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:95.00 stddev:2.56 (2.7%) stddev-sans-first:2.60 11:45:08 INFO - PROCESS | 8693 | Values: 95.0 97.0 100.0 96.0 96.0 101.0 101.0 95.0 95.0 95.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.39 11:45:08 INFO - PROCESS | 8693 | Values: 53.0 53.0 57.0 53.0 53.0 56.0 54.0 54.0 54.0 54.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 11:45:08 INFO - PROCESS | 8693 | Values: 59.0 60.0 61.0 60.0 60.0 62.0 60.0 59.0 60.0 61.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.00 stddev:8.04 (10.2%) stddev-sans-first:8.44 11:45:08 INFO - PROCESS | 8693 | Values: 78.0 78.0 79.0 80.0 78.0 79.0 79.0 79.0 104.0 78.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.00 stddev:4.67 (3.6%) stddev-sans-first:4.76 11:45:08 INFO - PROCESS | 8693 | Values: 124.0 132.0 128.0 121.0 134.0 127.0 133.0 130.0 127.0 121.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:2.32 (1.5%) stddev-sans-first:2.39 11:45:08 INFO - PROCESS | 8693 | Values: 156.0 155.0 156.0 157.0 159.0 155.0 159.0 160.0 157.0 162.0 11:45:08 INFO - PROCESS | 8693 | 11:45:08 INFO - PROCESS | 8693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:1.79 (2.9%) stddev-sans-first:1.51 11:45:08 INFO - PROCESS | 8693 | Values: 66.0 66.0 62.0 62.0 62.0 64.0 62.0 62.0 62.0 61.0 11:45:08 INFO - PROCESS | 8693 | -------- Summary: end -------- 11:45:08 INFO - PROCESS | 8693 | 11:45:09 INFO - TEST-INFO | 8693: exit 0 11:45:09 INFO - TEST-OK | kraken | took 61431ms 11:45:09 INFO - SUITE-END | took 1171s 11:45:09 INFO - Completed test suite (00:19:31) 11:45:09 INFO - javascript benchmark 11:45:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7613.478668553098, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.7309815214785, 3365.9663403365957, 3389.0849470642934, 3411.8805841795543, 3412.9658703412974, 5611.438856114387, 5649.6327738697055, 5663.292088488939, 5667.716614169291, 5672.06410942194, 5590.608657393984, 5598.384177740456, 5638.577106716992, 5648.209250704895, 5668.858278543038, 5075.74621268936, 5109.846704598868, 5135.435102138762, 5165.328507294065, 5170.25031370453, 5141.742912854361, 5143.228515722652, 5199.220116982445, 5199.792008319662, 5201.390756846686, 5171.637985341028, 5180.352455943007, 5217.5565076968505, 5245.055889939809, 5254.316938797951, 5181.637285390006, 5197.168453047513, 5254.605904557136, 5260.105782017066, 5261.763220655042, 5133.6149788765615, 5186.818461353834, 5187.481251874782, 5260.105782017066, 5270.972160428718, 5417.566594672417, 5439.156930675752, 5447.237386765856, 5485.424030476823, 5491.890162196773, 5980.521558275327, 6022.367651396584, 6026.427489388501, 6026.668533230671, 6041.124037014608, 6055.939440605625, 6088.543359248074, 6091.756329746805, 6093.817185484399, 6096.96951515244, 5685.744141513601, 5696.658200507983, 5747.885042299173, 5771.0, 5781.8554536136935, 6266.342034086447, 6288.308286088527, 6302.779402720883, 6316.242050953915, 6320.304766475684, 5879.235699359141, 5961.046232602763, 6041.5468839837185, 6064.151018857364, 6064.181335519648, 6049.304330002018, 6149.661768602769, 6167.629942203482, 6172.166757487771, 6179.0422484514975, 6065.480412824397, 6123.908141377883, 6133.26400831903, 6136.969315153396, 6142.04798256271, 5995.130706047598, 6028.246469191351, 6058.848528786815, 6125.509959203253, 6136.631802091889, 4660.277656963176, 4679.204535229019, 4680.625549956064, 4689.226277664216, 4694.718316900997, 4154.91690166195, 4167.6457501112745, 4168.687348448879, 4169.520505141887, 4197.4753155855515, 5809.302883653989, 5910.438508341701, 5914.142449344821, 5914.172015917775, 5937.821865344046, 6034.24571928509, 6068.302145253264, 6134.38656134383, 6141.140240366352, 6149.003147953866, 5915.260592425947, 5915.40845915405, 5924.11138329254, 5932.851678707981, 5942.346341902387, 5182.974085129626, 5223.164293712987, 5259.39516955555, 5288.021715982555, 5291.3385826771655, 6293.678327551174, 6365.809025729235, 6370.872582548416, 6385.233771947396, 6392.776252831129, 6046.09308603713, 6187.628742275478, 6201.10084037821, 6208.627482351073, 6233.906491402723, 6209.906851397323, 6235.469985051322, 6257.217847769029, 6319.557630965788, 6354.26925903527, 6002.069679199731, 6011.729472173675, 6014.127951446928, 6031.35346443827, 6079.696015199311, 5922.55580831448, 6102.542309326907, 6109.083637454418, 6119.816405507842, 6126.23422072241, 5958.5828991971875, 6032.276126864805, 6035.6076855004285, 6046.27444706638, 6073.089036644362, 5957.702114894151, 5962.0, 6027.156198132353, 6029.246344206974, 6038.365971573097, 5810.4189581041555, 5835.708214589338, 5848.561357898089, 5884.676342801187, 5942.584019118794, 5989.580729348903, 6047.727852246571, 6051.485623722033, 6065.5754097212775, 6102.938970610237, 5957.225560677084, 5970.820875373745, 5972.313183983723, 5983.192269043623, 5989.670568118621], "value": 5637.234988304607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4165438697271, 643.6910283064129, 663.2041550139832, 664.697562609013, 665.0091363867836, 43902.78048609757, 44951.426700065465, 45352.546474535244, 45666.543334566646, 48673.0, 47400.0, 47472.0, 47821.0, 47926.52073479264, 47934.52065479344, 9042.547872606376, 9158.908410915905, 9190.678326258583, 9195.862062069074, 9236.307276954221, 9112.908870911306, 9210.723678289662, 9211.170994610484, 9211.539423028855, 9246.35275530713, 9240.168384845363, 9245.676401325954, 9311.674091406801, 9326.1606455419, 9326.207272381856, 9150.816983660356, 9158.86261706075, 9205.677801276923, 9263.212626926686, 9277.768055798626, 9070.229030532413, 9106.635734570675, 9121.726348209564, 9135.269178465707, 9154.99295077541, 37366.81316593427, 37440.43839342412, 37671.81164094162, 37785.81107094474, 37848.81075594632, 3821.1211421372964, 3864.671502922255, 3988.3219852625125, 4170.791460426966, 4389.956100438987, 33360.332793343994, 33560.664393356, 33944.0, 34163.829180853936, 35091.649083509095, 4526.86419407415, 4673.135469938073, 4683.95316046842, 4688.460827004904, 4739.028499157665, 368554.0, 369876.0, 373163.0, 373785.0, 378360.99999999726, 37282.81358593189, 38260.617393825705, 48242.82907269181, 48499.272510912364, 48796.0, 40132.398014029815, 40159.397609035885, 40335.0, 40416.0, 40422.39366409506, 15620.375184992701, 15746.212689365715, 15764.448244311394, 15845.366185352686, 15880.126593037494, 13209.0, 13246.867531324757, 13332.933335333455, 13350.465981360638, 13356.666083347995, 9078.86381704275, 9121.680741174026, 9134.0, 9186.770330741785, 9202.079792020744, 3514.1741690702665, 3528.0, 3543.94684079739, 3578.9642103579154, 3594.4428613564414, 1039.5062345385882, 1082.2370228988543, 1096.2490693874563, 1212.4543955220186, 1283.794592865137, 32810.343793124484, 33071.66928330734, 33213.16967075794, 33218.50172247418, 33431.498527522104, 1150.988490115105, 1165.8484397028333, 1169.6198735411026, 1230.2311055590255, 1282.076904628666, 17300.0, 17310.480685579452, 17404.216810243568, 17431.825681743274, 17568.94586324799, 593959.0, 638876.0, 650238.0, 656898.0, 967851.0, 63773.68113159404, 63804.68097659575, 64072.0, 64304.67847660732, 64487.0, 1501.5345242974713, 1516.5071351810705, 1533.0035476939856, 1537.3773621683013, 1543.7684347347988, 32981.835090824396, 33533.83233083819, 33698.494522582674, 33841.49237761485, 34414.655853441145, 54852.72573637106, 55809.0, 55850.16224756713, 56032.0, 56121.15818262811, 474596.0, 474620.0, 475597.0, 476315.0, 476915.0, 30203.848980754956, 30833.845830770704, 30850.382992340477, 31023.379532409675, 31089.222769430944, 51420.22869656883, 52462.737686311324, 52976.73511632417, 53677.194842078185, 54049.0, 44313.77843110764, 44471.55528444803, 44730.3290450637, 45298.54701452943, 45525.0, 44293.55706442894, 44647.55352446434, 44885.551144488134, 45324.0, 45868.0, 43599.34600980925, 44709.0, 44804.77597611991, 44813.32780008368, 44948.55051449444, 37885.73999100293, 38108.61891381162, 38395.42406863844, 39260.6073939257, 39747.80126099351, 29301.0, 29637.2590685226, 30067.3986520264, 30297.394052119274, 30397.0], "value": 20111.09364846152, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5136703437186, 398.98005099745006, 424.78760619690155, 426.0669134595237, 430.3243907065906, 18817.247310107596, 20496.50031724463, 20865.0, 21043.263485777963, 21715.131394744192, 11798.764024719521, 16281.918590407031, 19638.803611963875, 20405.897970510163, 20463.488412789688, 5176.611754118447, 5440.129579267318, 5445.346558412976, 5450.427705090968, 5474.151506516497, 5387.299651045359, 5415.702136382497, 5480.095784195603, 5703.087505999041, 5724.856878578048, 5732.885342293152, 5746.0806270996645, 5764.913526297109, 5789.710514474281, 5826.504747096502, 5917.20117784098, 5932.288125424955, 5958.106284057383, 5962.73167707452, 5978.940210597903, 5047.116754567973, 5342.946570534323, 5368.731563421852, 5762.510186634141, 5778.0466223073145, 14360.712785744226, 14572.708545829024, 14622.488212912496, 23232.186873459515, 24004.279871603707, 2275.6586512023164, 2355.823313251513, 2372.1341710275797, 2474.8762561871836, 2598.1945596864844, 10003.79992400148, 10313.793724125475, 11937.94031029848, 14439.061461005105, 15394.15332156731, 2047.2220556188554, 2064.4322811227034, 2074.0, 2074.968875466869, 2084.9791502084936, 56587.43412565863, 88048.55975720144, 89141.10858891394, 89798.5510072452, 91769.54115229448, 11549.826752598718, 11693.298402095901, 12456.937715311366, 12520.436580353724, 12728.10903236783, 14529.709405811824, 17034.659306814043, 17211.741823872653, 17258.913705431394, 17259.309627615006, 7573.583452910033, 7989.2809647132035, 8055.516668999879, 8266.380021498411, 8268.421210515327, 7545.056867891513, 7620.695172193161, 7624.085109786861, 7700.345470634947, 7953.443258971932, 4677.158111539956, 4692.0850434165695, 4721.244600863914, 4742.454617718938, 5252.133397989289, 2022.5044864008412, 2036.7250421193246, 2099.6955441460905, 2146.441925099485, 2167.089822274648, 1006.7483129217695, 1025.1491262252312, 1075.295681328731, 1121.4168632311153, 1157.8089615213564, 19641.0, 19969.700454493195, 20071.39785806428, 20335.288264910658, 20777.480562985744, 993.9602415903428, 998.0767789794411, 1014.0721240065405, 1016.9694909152737, 1043.6921108272925, 10797.46012699362, 11089.83365249522, 11146.665600032013, 11188.384638844778, 11415.143864210217, 519050.0, 543872.0, 544803.0, 557778.0, 559271.0, 100652.49673751584, 101729.0, 102045.48977255066, 102871.48564257131, 103744.48127759314, 1048.4076496779296, 1053.6522947427331, 1063.2132222155703, 1066.626680661762, 1072.4423299884018, 17534.82465175383, 18053.819461805215, 18234.817651823843, 18348.082595869888, 18565.071746412355, 37132.44301335428, 40645.0, 44105.77947110244, 44617.77691111524, 45548.31677524774, 62043.689781550805, 62192.37807621866, 64174.0, 64177.358226419004, 64375.67812161097, 8614.396992210484, 8676.002259740211, 8740.694075707319, 8806.691765788166, 9118.498482583256, 9220.815583688154, 13369.465221391036, 13457.327133643083, 13643.931780341034, 14354.49759258421, 11569.132315076235, 11806.822897656713, 12038.75922481528, 12090.274583525017, 12174.695632609255, 11611.129165312466, 11755.294682319089, 11799.941000294944, 12005.339706316236, 12072.698182545506, 11957.701057473285, 12001.339926303788, 12319.199252048587, 12737.74524509486, 13035.543755968496, 8945.552722363725, 9020.819583608421, 9036.412633178823, 9118.179363857285, 9585.376950498474, 9240.445573265626, 12295.0, 12579.811302830647, 12816.935915320737, 12881.48474061027], "value": 9493.116996309824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.4786824611388, 1518.1270769307644, 1533.9539813805575, 1542.2134711297235, 1593.9442119525816, 8078.394120440976, 8659.480431174134, 8691.652333906635, 9363.812723745521, 9370.718878433649, 8898.555072246378, 9084.27325813935, 9109.817803643924, 9169.449833010023, 9223.0, 2372.6678265042906, 2414.3360575841607, 2416.613341865302, 2417.069428270111, 2419.733829278778, 2350.6944097267415, 2352.882355882199, 2407.2296865003204, 2407.590709579367, 2419.5644783938883, 2340.8127349812057, 2345.3433038749176, 2380.631002194654, 2384.4873352229356, 2411.553862535428, 2256.6953461282765, 2284.8743319117443, 2286.737025242102, 2288.1533832481923, 2330.557194133109, 2217.4899773052125, 2218.8446808723234, 2221.0560511782587, 2225.6550234713645, 2350.7061617297836, 9389.577469013911, 9540.0, 9540.379875308083, 9548.761280967961, 9559.283053770994, 5321.201819727034, 5328.600354973392, 5455.509004189642, 5475.753591088411, 5480.424555421703, 3499.0, 3534.6111927687934, 3582.5521809773777, 3583.1937813991644, 3636.3272794533095, 1189.3696340939316, 1201.0451690905752, 1220.8840160184768, 1228.6068458093414, 1237.9504819807196, 13426.731465370736, 13426.86573134266, 13447.529336473275, 13465.0, 13466.730665386638, 4812.783424745895, 4813.542713442287, 4822.517748225149, 4904.288878112725, 4916.483769204182, 11102.056325212447, 11167.664970050912, 11173.10615150786, 11174.888251117385, 11184.105271578253, 5607.186957891165, 5647.068233741386, 5651.067573850269, 5655.293088363955, 5661.801836935688, 4552.795124219418, 4983.277424773388, 5067.746612669352, 5220.608454365938, 5235.764390602432, 4152.231837110084, 4162.458880345535, 4232.090100628379, 4240.703150779415, 4269.97520595055, 1314.4216544720293, 1323.1267363540017, 1327.966800829987, 1350.797380392949, 1355.1462578575433, 850.8723691446208, 907.6051917415945, 931.9347645664739, 999.9850152095629, 1036.5801850250662, 6287.717052732638, 6378.043293506012, 6384.936150638527, 6443.548951573439, 6536.444402225864, 974.6247694637616, 976.0532283684814, 991.9008099190023, 1006.2201793610011, 1026.584233385465, 4415.955840441618, 4497.168023915586, 4535.4103966484145, 4541.500434952152, 4579.152856721451, 11864.406779660982, 12058.216215945935, 12150.149489535825, 12168.209066410654, 12184.147109702413, 11105.722356941142, 11635.88364116348, 11949.64151075469, 12040.81938770919, 12125.818112728317, 8780.473171609723, 8926.73219803407, 8940.731778046538, 8968.551572421353, 8987.775305617412, 6313.652749098844, 6432.6462044588, 6523.054157147282, 6565.244996825235, 6645.867082658223, 10381.9480902595, 10788.730281743019, 11051.392173430539, 11055.668329950115, 11138.443077846237, 10955.0, 10997.725056873642, 11003.394813285346, 11065.834012489659, 11212.943935280598, 8132.0, 8148.470349427268, 8167.979002624672, 8280.420370574244, 8322.375821813268, 9047.321450891079, 9110.635574577207, 9129.543522823966, 9154.176124148858, 9185.954070229605, 8118.797030074295, 8290.751277461686, 8315.916840831514, 8387.161283871565, 8399.286060684666, 7721.652525636247, 7736.613169341623, 7884.172161923145, 8063.717769878026, 8148.5518296494265, 7362.3373896349585, 7391.039164908528, 7399.18608953004, 7452.925470745223, 7623.0, 5352.116900711339, 5379.838604841861, 5396.676199428047, 5418.241446197457, 5434.3207099112615, 5409.4590540947165, 5451.809186678447, 5473.562115030708, 5511.586631002771, 5608.523275521627], "value": 4890.8016826346275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.5542716754635, 342.5427054881733, 350.9104231361622, 352.3516729218238, 358.49452272296054, 5712.343080545738, 5716.742746576404, 5851.678157701324, 5868.970655146718, 5895.204147440094, 5711.371749107595, 5730.79942202023, 5757.0, 5769.596128271022, 5785.537157027427, 4264.23243816113, 4461.263891457906, 4489.618382437497, 4494.8202071917085, 4534.727916325014, 4408.5591440855815, 4420.447444069491, 4433.359656926926, 4457.24226881431, 4469.340742258351, 4398.98823270648, 4419.160359531695, 4427.89674904421, 4439.600435960763, 4446.822127114911, 4438.800253988578, 4447.353824474432, 4449.310356894686, 4456.844010459618, 4488.236999710057, 3730.9626903730887, 3891.3579259422163, 3896.220755848813, 3924.2347742190286, 3933.449317095609, 5508.807191748269, 5543.168524721284, 5550.639208451478, 5585.4919171823785, 5590.580706447033, 5105.361829771278, 5115.641905066647, 5145.665531740425, 5149.201873709581, 5185.688858668492, 5753.395893431171, 6040.516758659297, 6040.607360521596, 6040.969795150996, 6076.361981991871, 4283.700140990132, 4292.120115376371, 4297.226499230137, 4302.290122129845, 4327.221100201962, 5605.69698218955, 6151.231096113031, 6241.906371404432, 6330.335314791927, 6355.936440635581, 4325.1565944641125, 4340.782960852008, 4358.651307895424, 4365.716228445141, 4370.475542934868, 4400.393856242513, 4409.603135717801, 4411.911761764811, 4433.423654924839, 4446.26636604963, 5010.398752149766, 5044.394672639307, 5080.390353157571, 5094.133997220481, 5109.901371205208, 5952.791652292149, 5995.790147344822, 6012.669303188367, 6022.759089636453, 6036.426539478743, 1500.7823865539654, 1528.7248295306729, 1535.7005383950245, 1539.568920702205, 1541.2216830500524, 942.8821397325335, 974.4104816586005, 978.8042391521582, 982.8378317577663, 986.5461887531673, 5238.607104467104, 5250.317458730417, 5270.235815806686, 5274.3385833462335, 5328.387235467893, 5453.454654534515, 5529.474699903583, 5535.501804837584, 5538.363088244822, 5550.58370622205, 4988.7505624718615, 5268.420473747885, 5295.417504074626, 5298.708571028554, 5372.301600791872, 2973.4945059339966, 2996.325826689021, 2996.4905965985836, 3009.3981203759336, 3018.471767440733, 5533.0, 5666.979943610189, 5764.971175144097, 5771.85570360736, 5779.8555036124435, 5550.250716153349, 5575.972120139373, 5628.242161340995, 5652.717364131777, 5659.0, 5657.321121465368, 6251.343608921089, 6488.188976377953, 6540.509461790385, 6580.309067547839, 6318.241810982711, 6326.620402775849, 6343.55595108338, 6356.713947872265, 6380.680965951777, 6018.2778066630535, 6187.906046976512, 6240.968795155995, 6263.34021484298, 6297.1813664223355, 6429.9678501607195, 6519.706613202512, 6537.803865884031, 6553.475721942138, 6581.078648989241, 4408.58118478744, 4418.100216906761, 4424.579664931826, 4431.7340959542535, 4446.933296000628, 5956.493698035542, 6278.529110316836, 6285.182926219562, 6344.9048264277, 6386.361363863576, 6121.84695382619, 6200.937990620036, 6202.968985155226, 6212.689365531615, 6221.222347206599, 5960.672163030901, 6066.059760737093, 6080.90878636812, 6134.938650613615, 6232.594881332699, 6011.549133815069, 6014.097885317237, 6039.275286965592, 6062.363451837494, 6089.421504957022, 5944.524438045032, 6184.907226391698, 6186.1030150627, 6200.81397558074, 6227.719752611053, 6022.668753218615, 6062.242219722535, 6097.695115244132, 6099.566601848651, 6150.723217455135], "value": 4521.418517371709, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.3116270705536, 758.5107605594395, 791.7743443118712, 874.7463235661658, 916.2120576304379, 16111.35554577817, 16504.257308421118, 17034.148292585367, 17213.741793873072, 17553.736693949602, 16294.185290735446, 16484.505464836075, 16530.42143524977, 16533.58666033347, 16584.585385365343, 871.995640021799, 873.083262574296, 895.740235331753, 901.0673952459206, 903.4398672822826, 899.7390756680587, 902.3187493442442, 906.4697152165991, 907.591583787295, 912.5756523216703, 944.8204841080172, 946.9905300946971, 953.6614501851847, 953.8378475659119, 954.5179684259474, 935.4153653966305, 943.7829299261208, 947.3463310315894, 950.4772375193651, 950.8589692369185, 694.6804469943831, 696.7526528082559, 696.7839969609437, 696.9686364113627, 698.5075521757149, 15588.92205538965, 15631.0, 15676.137812420313, 15679.372825086983, 15757.0, 14921.179335136563, 15038.248087595577, 15047.0, 15083.47207847731, 15138.772918406232, 12525.311107889063, 12660.430280637393, 12775.29735864527, 12790.808137877939, 12917.0, 4051.6424904042847, 4082.632563069338, 4110.05468742191, 4154.688398370135, 4176.644985176264, 84539.5773021131, 85984.0, 87877.56061219652, 88120.55939720325, 89997.0, 12409.93795031019, 12426.56507022268, 12480.251184928751, 12486.937565312297, 12656.0, 22854.17166626666, 22857.0, 22973.195938142086, 22999.770002300098, 23042.0, 8852.203301702877, 8935.419197752126, 8986.0, 9076.81846363069, 9226.30802689801, 5057.241413787961, 5247.2653828464045, 5281.551068159172, 5308.575313974873, 5408.91886621701, 3392.796432214075, 3509.4911237870874, 3520.8415621297104, 3975.0857302820514, 4137.110521237948, 681.0533358631507, 684.0662495693343, 695.4679670052413, 696.5890124826276, 704.3907020427396, 694.5624256718235, 698.6227437183863, 761.2805898425935, 789.9368050555942, 802.2338666573409, 10103.0, 10227.28409011362, 10347.586096556204, 10404.947975260075, 10423.166146708245, 642.3287664390723, 753.4273951796674, 826.0706704956923, 853.1766844994486, 873.5588527793424, 4925.630577706686, 5147.503460821498, 5193.065248255275, 5260.2109683547005, 5394.541463975527, 75543.0, 91986.0, 118326.40836795761, 119220.40389797995, 121632.0, 103747.0, 107346.75802222133, 107431.0, 108288.0, 108405.0, 93604.0639593609, 94199.52900235592, 94817.0, 95131.52434237784, 96026.0, 10162.136218421518, 10221.693349199535, 10335.22485813582, 10368.222383321432, 10407.063364296946, 48198.759006204746, 52919.99999999846, 53367.0, 53743.731281343345, 54237.0, 68933.65533172301, 72279.0, 78674.0, 79308.20691793009, 80212.0, 13277.468901244229, 14253.287335633384, 14319.427222910967, 14485.782713259521, 14561.708765824837, 15524.0, 15663.765043524128, 15737.842621574096, 16258.674826503167, 16750.246238919033, 14387.784183237469, 14443.49447769323, 15258.465953692012, 15390.769138462709, 15429.84570154329, 14724.779128313297, 15435.536933892, 15574.0, 15855.68288634244, 15868.76196857025, 14706.63233419173, 14950.028248163835, 15586.844131558993, 15640.139792311076, 15763.763543547086, 11790.0, 12172.33052182103, 12215.511379544718, 12372.1958072725, 12823.679408014874, 11690.240134391237, 12271.57049503263, 12284.201526900722, 12332.383380830743, 12848.486060557472], "value": 8182.638170233388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 111.0, 111.0, 112.0, 113.0, 112.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 128.0, 153.0, 173.0, 127.0, 161.0, 150.0, 135.0, 188.0, 136.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 167.0, 163.0, 163.0, 162.0, 163.0, 164.0, 165.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 171.0, 77.0, 75.0, 75.0, 76.0, 176.0, 78.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 152.0, 85.0, 85.0, 86.0, 145.0, 84.0, 84.0, 147.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 150.0, 151.0, 149.0, 150.0, 149.0, 146.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 100.0, 96.0, 96.0, 101.0, 101.0, 95.0, 95.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 57.0, 53.0, 53.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 60.0, 60.0, 62.0, 60.0, 59.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 80.0, 78.0, 79.0, 79.0, 79.0, 104.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 128.0, 121.0, 134.0, 127.0, 133.0, 130.0, 127.0, 121.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 156.0, 157.0, 159.0, 155.0, 159.0, 160.0, 157.0, 162.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 62.0, 62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 61.0], "value": 62.9, "unit": "score"}]}]} 11:45:09 INFO - Return code: 0 11:45:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:09 ERROR - # TBPL SUCCESS # 11:45:09 INFO - Running post-action listener: _resource_record_post_action 11:45:09 INFO - ##### 11:45:09 INFO - ##### Finished run-tests step (success) 11:45:09 INFO - ##### 11:45:09 INFO - Running post-run listener: _resource_record_post_run 11:45:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 261640192; Read time: 20; Write time: 162380 11:45:09 INFO - TinderboxPrint: CPU usage
13.4% 11:45:09 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 11:45:09 INFO - TinderboxPrint: I/O write bytes / time
261,640,192 / 162,380 11:45:09 INFO - TinderboxPrint: CPU idle
8,215.5 (86.6%) 11:45:09 INFO - TinderboxPrint: CPU user
1,216.3 (12.8%) 11:45:09 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15740928; Read time: 0; Write time: 7736 11:45:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245899264; Read time: 20; Write time: 154644 11:45:10 INFO - Running post-run listener: _upload_blobber_files 11:45:10 INFO - Blob upload gear active. 11:45:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:10 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 11:45:10 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'] 11:45:10 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 11:45:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:12 INFO - (blobuploader) - INFO - Done attempting. 11:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:13 INFO - (blobuploader) - INFO - Done attempting. 11:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:18 INFO - (blobuploader) - INFO - Done attempting. 11:45:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:18 INFO - Return code: 0 11:45:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc62097faafe12074426bf960774ca54058d93e92608aeca52921bf9a3c9981b191aed6a67690903c48b042fbdbcd69b7472c360675a9e5e5e699665d89b572", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebc44a93fa41e9e7c2ae1d09eb5710cbb09ef8940c35f8f1da59821a60f8e11f63c15af0521b76e39c14c040cbc1005ff705fa8e84458452b70bbd3b00313451", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a633fbbfbc626776dc263d2f6df9e7b42b7288dfed8859bd94deb7e9446ac4bcd162535fe6e969de0b9dc4c036a189ab7d8bd28093c432a71b7fb937e7b09e5"} 11:45:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:18 INFO - Contents: 11:45:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc62097faafe12074426bf960774ca54058d93e92608aeca52921bf9a3c9981b191aed6a67690903c48b042fbdbcd69b7472c360675a9e5e5e699665d89b572", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebc44a93fa41e9e7c2ae1d09eb5710cbb09ef8940c35f8f1da59821a60f8e11f63c15af0521b76e39c14c040cbc1005ff705fa8e84458452b70bbd3b00313451", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a633fbbfbc626776dc263d2f6df9e7b42b7288dfed8859bd94deb7e9446ac4bcd162535fe6e969de0b9dc4c036a189ab7d8bd28093c432a71b7fb937e7b09e5"} 11:45:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:18 INFO - Copying logs to upload dir... 11:45:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1341.594186 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-06-15 11:45:16.191091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:45:16.195033) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc62097faafe12074426bf960774ca54058d93e92608aeca52921bf9a3c9981b191aed6a67690903c48b042fbdbcd69b7472c360675a9e5e5e699665d89b572", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebc44a93fa41e9e7c2ae1d09eb5710cbb09ef8940c35f8f1da59821a60f8e11f63c15af0521b76e39c14c040cbc1005ff705fa8e84458452b70bbd3b00313451", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a633fbbfbc626776dc263d2f6df9e7b42b7288dfed8859bd94deb7e9446ac4bcd162535fe6e969de0b9dc4c036a189ab7d8bd28093c432a71b7fb937e7b09e5"} build_url:https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/YcjkUuFmRAyiUns9Q41syA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc62097faafe12074426bf960774ca54058d93e92608aeca52921bf9a3c9981b191aed6a67690903c48b042fbdbcd69b7472c360675a9e5e5e699665d89b572", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebc44a93fa41e9e7c2ae1d09eb5710cbb09ef8940c35f8f1da59821a60f8e11f63c15af0521b76e39c14c040cbc1005ff705fa8e84458452b70bbd3b00313451", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a633fbbfbc626776dc263d2f6df9e7b42b7288dfed8859bd94deb7e9446ac4bcd162535fe6e969de0b9dc4c036a189ab7d8bd28093c432a71b7fb937e7b09e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:45:16.226790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:45:16.227360) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466014882.307203-313086882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:45:16.312057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:45:16.312440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:45:16.312798) ========= ========= Total master_lag: 0.20 =========