builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1465038752.77 results: success (0) buildid: 20160604013006 builduid: 8eb8b346bccf425aaabb3689b9a93cf2 revision: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.771801) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.772495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.772796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.791106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.791410) ========= 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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 04:12:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.5M=0s 2016-06-04 04:12:33 (24.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136895 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.954173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:32.954483) ========= 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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.004479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.004817) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 --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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 04:12:33,378 truncating revision to first 12 chars 2016-06-04 04:12:33,378 Setting DEBUG logging. 2016-06-04 04:12:33,378 attempt 1/10 2016-06-04 04:12:33,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f3740cfc4b04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 04:12:33,711 unpacking tar archive at: mozilla-central-f3740cfc4b04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.690629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.690982) ========= script_repo_revision: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.691485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.691807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 04:12:33.701157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 04:12:33.701498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:34 INFO - MultiFileLogger online at 20160604 04:12:34 in /builds/slave/test 04:12:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:12:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:34 INFO - {'append_to_log': False, 04:12:34 INFO - 'base_work_dir': '/builds/slave/test', 04:12:34 INFO - 'blob_upload_branch': 'Firefox', 04:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:34 INFO - 'branch': 'Firefox', 04:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:34 INFO - 'config_files': ('talos/linux_config.py',), 04:12:34 INFO - 'default_actions': ('clobber', 04:12:34 INFO - 'read-buildbot-config', 04:12:34 INFO - 'download-and-extract', 04:12:34 INFO - 'populate-webroot', 04:12:34 INFO - 'create-virtualenv', 04:12:34 INFO - 'install', 04:12:34 INFO - 'run-tests'), 04:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:34 INFO - 'download_minidump_stackwalk': True, 04:12:34 INFO - 'download_symbols': 'ondemand', 04:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:34 INFO - 'installer_path': 'installer.exe', 04:12:34 INFO - 'log_level': 'info', 04:12:34 INFO - 'log_name': 'talos', 04:12:34 INFO - 'log_to_console': True, 04:12:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:34 INFO - 'opt_config_files': (), 04:12:34 INFO - 'pip_index': False, 04:12:34 INFO - 'sps_profile': False, 04:12:34 INFO - 'sps_profile_interval': 0, 04:12:34 INFO - 'suite': 'dromaeojs-e10s', 04:12:34 INFO - 'system_bits': '32', 04:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:34 INFO - 'title': 'talos-linux64-ix-031', 04:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:34 INFO - 'use_talos_json': True, 04:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:34 INFO - 'work_dir': 'build'} 04:12:34 INFO - ##### 04:12:34 INFO - ##### Running clobber step. 04:12:34 INFO - ##### 04:12:34 INFO - Running pre-action listener: _resource_record_pre_action 04:12:34 INFO - Running main action method: clobber 04:12:34 INFO - rmtree: /builds/slave/test/build 04:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:35 INFO - Running post-action listener: _resource_record_post_action 04:12:35 INFO - ##### 04:12:35 INFO - ##### Finished clobber step (success) 04:12:35 INFO - ##### 04:12:35 INFO - ##### 04:12:35 INFO - ##### Running read-buildbot-config step. 04:12:35 INFO - ##### 04:12:35 INFO - Running pre-action listener: _resource_record_pre_action 04:12:35 INFO - Running main action method: read_buildbot_config 04:12:35 INFO - Using buildbot properties: 04:12:35 INFO - { 04:12:35 INFO - "project": "", 04:12:35 INFO - "product": "firefox", 04:12:35 INFO - "script_repo_revision": "production", 04:12:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:12:35 INFO - "repository": "", 04:12:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:12:35 INFO - "buildid": "20160604013006", 04:12:35 INFO - "pgo_build": "True", 04:12:35 INFO - "basedir": "/builds/slave/test", 04:12:35 INFO - "buildnumber": 59, 04:12:35 INFO - "slavename": "talos-linux64-ix-031", 04:12:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:12:35 INFO - "platform": "ubuntu64_hw", 04:12:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:12:35 INFO - "branch": "mozilla-central", 04:12:35 INFO - "repo_path": "mozilla-central", 04:12:35 INFO - "revision": "f3740cfc4b04fb61a1da306df4b1c2437f6bfb65", 04:12:35 INFO - "stage_platform": "linux64-pgo", 04:12:35 INFO - "builduid": "8eb8b346bccf425aaabb3689b9a93cf2", 04:12:35 INFO - "slavebuilddir": "test" 04:12:35 INFO - } 04:12:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:12:35 INFO - Running post-action listener: _resource_record_post_action 04:12:35 INFO - ##### 04:12:35 INFO - ##### Finished read-buildbot-config step (success) 04:12:35 INFO - ##### 04:12:35 INFO - ##### 04:12:35 INFO - ##### Running download-and-extract step. 04:12:35 INFO - ##### 04:12:35 INFO - Running pre-action listener: _resource_record_pre_action 04:12:35 INFO - Running main action method: download_and_extract 04:12:35 INFO - mkdir: /builds/slave/test/build/tests 04:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:35 INFO - https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:12:36 INFO - Downloaded 1361 bytes. 04:12:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:12:36 INFO - Using the following test package requirements: 04:12:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:12:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'jsshell-linux-x86_64.zip'], 04:12:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:12:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:12:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:36 INFO - https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:37 INFO - Downloaded 24441287 bytes. 04:12:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:38 INFO - Return code: 0 04:12:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:38 INFO - https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:40 INFO - Downloaded 24441287 bytes. 04:12:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:41 INFO - Return code: 0 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:41 INFO - https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:12:42 INFO - Downloaded 10833369 bytes. 04:12:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:12:43 INFO - Return code: 0 04:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:43 INFO - https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:12:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:44 INFO - Downloaded 59129756 bytes. 04:12:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:44 INFO - mkdir: /builds/slave/test/properties 04:12:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:44 INFO - Contents: 04:12:44 INFO - build_url:https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:45 INFO - Running post-action listener: _resource_record_post_action 04:12:45 INFO - Running post-action listener: set_extra_try_arguments 04:12:45 INFO - ##### 04:12:45 INFO - ##### Finished download-and-extract step (success) 04:12:45 INFO - ##### 04:12:45 INFO - ##### 04:12:45 INFO - ##### Running populate-webroot step. 04:12:45 INFO - ##### 04:12:45 INFO - Running pre-action listener: _resource_record_pre_action 04:12:45 INFO - Running main action method: populate_webroot 04:12:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:45 INFO - '--tppagecycles', 04:12:45 INFO - '7'], 04:12:45 INFO - 'tests': ['tsvgm']}}, 04:12:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['damp', 'tps']}, 04:12:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['damp', 'tps']}, 04:12:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['dromaeo_dom']}, 04:12:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['a11yr', 04:12:45 INFO - 'ts_paint', 04:12:45 INFO - 'tpaint', 04:12:45 INFO - 'sessionrestore', 04:12:45 INFO - 'sessionrestore_no_auto_restore', 04:12:45 INFO - 'tabpaint']}, 04:12:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tsvgx', 04:12:45 INFO - 'tsvgr_opacity', 04:12:45 INFO - 'tart', 04:12:45 INFO - 'tscrollx', 04:12:45 INFO - 'cart']}, 04:12:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:45 INFO - 'tsvgr_opacity', 04:12:45 INFO - 'tart', 04:12:45 INFO - 'tscrollx', 04:12:45 INFO - 'cart']}, 04:12:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s'], 04:12:45 INFO - 'tests': ['tp5o']}, 04:12:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'tests': ['tp5o']}, 04:12:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--disable-e10s', 04:12:45 INFO - '--xperf_path', 04:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:45 INFO - 'tests': ['tp5n']}, 04:12:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:45 INFO - 'talos_options': ['--xperf_path', 04:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:45 INFO - 'tests': ['tp5n']}}, 04:12:45 INFO - 'talos.zip': {'path': '', 04:12:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:45 INFO - Running post-action listener: _resource_record_post_action 04:12:45 INFO - ##### 04:12:45 INFO - ##### Finished populate-webroot step (success) 04:12:45 INFO - ##### 04:12:45 INFO - ##### 04:12:45 INFO - ##### Running create-virtualenv step. 04:12:45 INFO - ##### 04:12:45 INFO - Running pre-action listener: _resource_record_pre_action 04:12:45 INFO - Running main action method: create_virtualenv 04:12:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:45 INFO - Using real prefix '/usr' 04:12:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:47 INFO - Installing pip.................done. 04:12:47 INFO - Return code: 0 04:12:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:47 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:12:47 INFO - Using env: {'DISPLAY': ':0', 04:12:47 INFO - 'HOME': '/home/cltbld', 04:12:47 INFO - 'LANG': 'en_US.UTF-8', 04:12:47 INFO - 'LANGUAGE': 'en_US:en', 04:12:47 INFO - 'LOGNAME': 'cltbld', 04:12:47 INFO - 'MAIL': '/var/mail/cltbld', 04:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:47 INFO - 'MOZ_NO_REMOTE': '1', 04:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:47 INFO - 'NO_EM_RESTART': '1', 04:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:47 INFO - 'PWD': '/builds/slave/test', 04:12:47 INFO - 'SHELL': '/bin/bash', 04:12:47 INFO - 'SHLVL': '1', 04:12:47 INFO - 'TERM': 'linux', 04:12:47 INFO - 'TMOUT': '86400', 04:12:47 INFO - 'USER': 'cltbld', 04:12:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:47 INFO - '_': '/tools/buildbot/bin/python'} 04:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:12:47 INFO - Cleaning up... 04:12:48 INFO - Return code: 0 04:12:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:48 INFO - Downloading/unpacking psutil>=3.1.1 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:50 INFO - Installing collected packages: psutil 04:12:50 INFO - Running setup.py install for psutil 04:12:50 INFO - building 'psutil._psutil_linux' extension 04:12:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:12:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:12:50 INFO - building 'psutil._psutil_posix' extension 04:12:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:12:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:50 INFO - Successfully installed psutil 04:12:50 INFO - Cleaning up... 04:12:50 INFO - Return code: 0 04:12:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:12:50 INFO - Using env: {'DISPLAY': ':0', 04:12:50 INFO - 'HOME': '/home/cltbld', 04:12:50 INFO - 'LANG': 'en_US.UTF-8', 04:12:50 INFO - 'LANGUAGE': 'en_US:en', 04:12:50 INFO - 'LOGNAME': 'cltbld', 04:12:50 INFO - 'MAIL': '/var/mail/cltbld', 04:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:50 INFO - 'MOZ_NO_REMOTE': '1', 04:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:50 INFO - 'NO_EM_RESTART': '1', 04:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:50 INFO - 'PWD': '/builds/slave/test', 04:12:50 INFO - 'SHELL': '/bin/bash', 04:12:50 INFO - 'SHLVL': '1', 04:12:50 INFO - 'TERM': 'linux', 04:12:50 INFO - 'TMOUT': '86400', 04:12:50 INFO - 'USER': 'cltbld', 04:12:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:50 INFO - '_': '/tools/buildbot/bin/python'} 04:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:52 INFO - Installing collected packages: mozsystemmonitor 04:12:52 INFO - Running setup.py install for mozsystemmonitor 04:12:53 INFO - Successfully installed mozsystemmonitor 04:12:53 INFO - Cleaning up... 04:12:53 INFO - Return code: 0 04:12:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:53 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:12:53 INFO - Using env: {'DISPLAY': ':0', 04:12:53 INFO - 'HOME': '/home/cltbld', 04:12:53 INFO - 'LANG': 'en_US.UTF-8', 04:12:53 INFO - 'LANGUAGE': 'en_US:en', 04:12:53 INFO - 'LOGNAME': 'cltbld', 04:12:53 INFO - 'MAIL': '/var/mail/cltbld', 04:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:53 INFO - 'MOZ_NO_REMOTE': '1', 04:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:53 INFO - 'NO_EM_RESTART': '1', 04:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:53 INFO - 'PWD': '/builds/slave/test', 04:12:53 INFO - 'SHELL': '/bin/bash', 04:12:53 INFO - 'SHLVL': '1', 04:12:53 INFO - 'TERM': 'linux', 04:12:53 INFO - 'TMOUT': '86400', 04:12:53 INFO - 'USER': 'cltbld', 04:12:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:53 INFO - '_': '/tools/buildbot/bin/python'} 04:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:55 INFO - warning: no files found matching '*.txt' 04:12:55 INFO - no previously-included directories found matching 'build' 04:12:55 INFO - no previously-included directories found matching 'dist' 04:12:55 INFO - no previously-included directories found matching '.git*' 04:12:55 INFO - Installing collected packages: jsonschema, functools32 04:12:55 INFO - Running setup.py install for functools32 04:12:55 INFO - warning: no files found matching '*.txt' 04:12:55 INFO - no previously-included directories found matching 'build' 04:12:55 INFO - no previously-included directories found matching 'dist' 04:12:55 INFO - no previously-included directories found matching '.git*' 04:12:55 INFO - Successfully installed jsonschema functools32 04:12:55 INFO - Cleaning up... 04:12:55 INFO - Return code: 0 04:12:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:12:55 INFO - Using env: {'DISPLAY': ':0', 04:12:55 INFO - 'HOME': '/home/cltbld', 04:12:55 INFO - 'LANG': 'en_US.UTF-8', 04:12:55 INFO - 'LANGUAGE': 'en_US:en', 04:12:55 INFO - 'LOGNAME': 'cltbld', 04:12:55 INFO - 'MAIL': '/var/mail/cltbld', 04:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:55 INFO - 'MOZ_NO_REMOTE': '1', 04:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:55 INFO - 'NO_EM_RESTART': '1', 04:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:55 INFO - 'PWD': '/builds/slave/test', 04:12:55 INFO - 'SHELL': '/bin/bash', 04:12:55 INFO - 'SHLVL': '1', 04:12:55 INFO - 'TERM': 'linux', 04:12:55 INFO - 'TMOUT': '86400', 04:12:55 INFO - 'USER': 'cltbld', 04:12:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:55 INFO - '_': '/tools/buildbot/bin/python'} 04:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:58 INFO - Downloading docopt-0.6.1.tar.gz 04:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:58 INFO - Running setup.py install for blobuploader 04:12:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:58 INFO - Running setup.py install for requests 04:12:58 INFO - Running setup.py install for docopt 04:12:59 INFO - Successfully installed blobuploader requests docopt 04:12:59 INFO - Cleaning up... 04:12:59 INFO - Return code: 0 04:12:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:59 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:59 INFO - Using env: {'DISPLAY': ':0', 04:12:59 INFO - 'HOME': '/home/cltbld', 04:12:59 INFO - 'LANG': 'en_US.UTF-8', 04:12:59 INFO - 'LANGUAGE': 'en_US:en', 04:12:59 INFO - 'LOGNAME': 'cltbld', 04:12:59 INFO - 'MAIL': '/var/mail/cltbld', 04:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:59 INFO - 'MOZ_NO_REMOTE': '1', 04:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:59 INFO - 'NO_EM_RESTART': '1', 04:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:59 INFO - 'PWD': '/builds/slave/test', 04:12:59 INFO - 'SHELL': '/bin/bash', 04:12:59 INFO - 'SHLVL': '1', 04:12:59 INFO - 'TERM': 'linux', 04:12:59 INFO - 'TMOUT': '86400', 04:12:59 INFO - 'USER': 'cltbld', 04:12:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:59 INFO - '_': '/tools/buildbot/bin/python'} 04:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:59 INFO - Running setup.py (path:/tmp/pip-yzC_ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:59 INFO - Running setup.py (path:/tmp/pip-d8aFuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:59 INFO - Running setup.py (path:/tmp/pip-Iq0wwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:59 INFO - Running setup.py (path:/tmp/pip-_xIXF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:59 INFO - Running setup.py (path:/tmp/pip-h_ma6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:59 INFO - Running setup.py (path:/tmp/pip-qOxrsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:59 INFO - Running setup.py (path:/tmp/pip-0K0rNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:59 INFO - Running setup.py (path:/tmp/pip-uNoFbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:59 INFO - Running setup.py (path:/tmp/pip-lPyHRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:00 INFO - Running setup.py (path:/tmp/pip-gq3Hj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:00 INFO - Running setup.py (path:/tmp/pip-f5M9hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:00 INFO - Running setup.py (path:/tmp/pip-xmDZ13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:00 INFO - Running setup.py (path:/tmp/pip-Q54V9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:00 INFO - Running setup.py (path:/tmp/pip-zhDJX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:00 INFO - Running setup.py (path:/tmp/pip-6oslrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:00 INFO - Running setup.py (path:/tmp/pip-AUEITr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:00 INFO - Running setup.py (path:/tmp/pip-nWS3Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:00 INFO - Running setup.py install for manifestparser 04:13:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozcrash 04:13:00 INFO - Running setup.py install for mozdebug 04:13:00 INFO - Running setup.py install for mozdevice 04:13:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozfile 04:13:01 INFO - Running setup.py install for mozhttpd 04:13:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozinfo 04:13:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozInstall 04:13:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozleak 04:13:01 INFO - Running setup.py install for mozlog 04:13:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for moznetwork 04:13:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozprocess 04:13:01 INFO - Running setup.py install for mozprofile 04:13:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozrunner 04:13:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Running setup.py install for mozscreenshot 04:13:02 INFO - Running setup.py install for moztest 04:13:02 INFO - Running setup.py install for mozversion 04:13:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:02 INFO - Cleaning up... 04:13:02 INFO - Return code: 0 04:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:02 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:02 INFO - Using env: {'DISPLAY': ':0', 04:13:02 INFO - 'HOME': '/home/cltbld', 04:13:02 INFO - 'LANG': 'en_US.UTF-8', 04:13:02 INFO - 'LANGUAGE': 'en_US:en', 04:13:02 INFO - 'LOGNAME': 'cltbld', 04:13:02 INFO - 'MAIL': '/var/mail/cltbld', 04:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:02 INFO - 'MOZ_NO_REMOTE': '1', 04:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:02 INFO - 'NO_EM_RESTART': '1', 04:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:02 INFO - 'PWD': '/builds/slave/test', 04:13:02 INFO - 'SHELL': '/bin/bash', 04:13:02 INFO - 'SHLVL': '1', 04:13:02 INFO - 'TERM': 'linux', 04:13:02 INFO - 'TMOUT': '86400', 04:13:02 INFO - 'USER': 'cltbld', 04:13:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:02 INFO - '_': '/tools/buildbot/bin/python'} 04:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:02 INFO - Running setup.py (path:/tmp/pip-zDzJsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:02 INFO - Running setup.py (path:/tmp/pip-XxQ00E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:02 INFO - Running setup.py (path:/tmp/pip-fsvVoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:02 INFO - Running setup.py (path:/tmp/pip-jYnElG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:02 INFO - Running setup.py (path:/tmp/pip-wZvpc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:03 INFO - Running setup.py (path:/tmp/pip-r2MHwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:03 INFO - Running setup.py (path:/tmp/pip-ylGSym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:03 INFO - Running setup.py (path:/tmp/pip-I_2nMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:03 INFO - Running setup.py (path:/tmp/pip-Ywvkq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:03 INFO - Running setup.py (path:/tmp/pip-XsMH8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:03 INFO - Running setup.py (path:/tmp/pip-sW2EGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:03 INFO - Running setup.py (path:/tmp/pip-5LoMHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:03 INFO - Running setup.py (path:/tmp/pip-fzyUGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:03 INFO - Running setup.py (path:/tmp/pip-_QUvhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:03 INFO - Running setup.py (path:/tmp/pip-g2FrPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:03 INFO - Running setup.py (path:/tmp/pip-n1ffrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:03 INFO - Running setup.py (path:/tmp/pip-8MxIKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:05 INFO - Downloading blessings-1.6.tar.gz 04:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:05 INFO - Installing collected packages: blessings 04:13:05 INFO - Running setup.py install for blessings 04:13:05 INFO - Successfully installed blessings 04:13:05 INFO - Cleaning up... 04:13:05 INFO - Return code: 0 04:13:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:06 INFO - Reading from file tmpfile_stdout 04:13:06 INFO - Current package versions: 04:13:06 INFO - argparse == 1.2.1 04:13:06 INFO - blessings == 1.6 04:13:06 INFO - blobuploader == 1.2.4 04:13:06 INFO - docopt == 0.6.1 04:13:06 INFO - functools32 == 3.2.3-2 04:13:06 INFO - jsonschema == 2.5.1 04:13:06 INFO - manifestparser == 1.1 04:13:06 INFO - mozInstall == 1.12 04:13:06 INFO - mozcrash == 0.17 04:13:06 INFO - mozdebug == 0.1 04:13:06 INFO - mozdevice == 0.48 04:13:06 INFO - mozfile == 1.2 04:13:06 INFO - mozhttpd == 0.7 04:13:06 INFO - mozinfo == 0.9 04:13:06 INFO - mozleak == 0.1 04:13:06 INFO - mozlog == 3.2 04:13:06 INFO - moznetwork == 0.27 04:13:06 INFO - mozprocess == 0.22 04:13:06 INFO - mozprofile == 0.28 04:13:06 INFO - mozrunner == 6.11 04:13:06 INFO - mozscreenshot == 0.1 04:13:06 INFO - mozsystemmonitor == 0.3 04:13:06 INFO - moztest == 0.7 04:13:06 INFO - mozversion == 1.4 04:13:06 INFO - psutil == 3.1.1 04:13:06 INFO - requests == 1.2.3 04:13:06 INFO - wsgiref == 0.1.2 04:13:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:06 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 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:06 INFO - Using env: {'DISPLAY': ':0', 04:13:06 INFO - 'HOME': '/home/cltbld', 04:13:06 INFO - 'LANG': 'en_US.UTF-8', 04:13:06 INFO - 'LANGUAGE': 'en_US:en', 04:13:06 INFO - 'LOGNAME': 'cltbld', 04:13:06 INFO - 'MAIL': '/var/mail/cltbld', 04:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:06 INFO - 'MOZ_NO_REMOTE': '1', 04:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:06 INFO - 'NO_EM_RESTART': '1', 04:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:06 INFO - 'PWD': '/builds/slave/test', 04:13:06 INFO - 'SHELL': '/bin/bash', 04:13:06 INFO - 'SHLVL': '1', 04:13:06 INFO - 'TERM': 'linux', 04:13:06 INFO - 'TMOUT': '86400', 04:13:06 INFO - 'USER': 'cltbld', 04:13:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:06 INFO - '_': '/tools/buildbot/bin/python'} 04:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:06 INFO - Cleaning up... 04:13:06 INFO - Return code: 0 04:13:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13: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', 'jsonschema'] in /builds/slave/test/build 04:13: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 jsonschema 04:13:06 INFO - Using env: {'DISPLAY': ':0', 04:13:06 INFO - 'HOME': '/home/cltbld', 04:13:06 INFO - 'LANG': 'en_US.UTF-8', 04:13:06 INFO - 'LANGUAGE': 'en_US:en', 04:13:06 INFO - 'LOGNAME': 'cltbld', 04:13:06 INFO - 'MAIL': '/var/mail/cltbld', 04:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:06 INFO - 'MOZ_NO_REMOTE': '1', 04:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:06 INFO - 'NO_EM_RESTART': '1', 04:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:06 INFO - 'PWD': '/builds/slave/test', 04:13:06 INFO - 'SHELL': '/bin/bash', 04:13:06 INFO - 'SHLVL': '1', 04:13:06 INFO - 'TERM': 'linux', 04:13:06 INFO - 'TMOUT': '86400', 04:13:06 INFO - 'USER': 'cltbld', 04:13:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:06 INFO - '_': '/tools/buildbot/bin/python'} 04:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:06 INFO - Cleaning up... 04:13:06 INFO - Return code: 0 04:13:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6830b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13: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', 'flake8'] in /builds/slave/test/build 04:13: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 flake8 04:13:06 INFO - Using env: {'DISPLAY': ':0', 04:13:06 INFO - 'HOME': '/home/cltbld', 04:13:06 INFO - 'LANG': 'en_US.UTF-8', 04:13:06 INFO - 'LANGUAGE': 'en_US:en', 04:13:06 INFO - 'LOGNAME': 'cltbld', 04:13:06 INFO - 'MAIL': '/var/mail/cltbld', 04:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:06 INFO - 'MOZ_NO_REMOTE': '1', 04:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:06 INFO - 'NO_EM_RESTART': '1', 04:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:06 INFO - 'PWD': '/builds/slave/test', 04:13:06 INFO - 'SHELL': '/bin/bash', 04:13:06 INFO - 'SHLVL': '1', 04:13:06 INFO - 'TERM': 'linux', 04:13:06 INFO - 'TMOUT': '86400', 04:13:06 INFO - 'USER': 'cltbld', 04:13:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:06 INFO - '_': '/tools/buildbot/bin/python'} 04:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:06 INFO - Downloading/unpacking flake8 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:09 INFO - no previously-included directories found matching 'docs/_build' 04:13:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:09 INFO - Running setup.py install for pep8 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:09 INFO - no previously-included directories found matching 'docs/_build' 04:13:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:09 INFO - Cleaning up... 04:13:09 INFO - Return code: 0 04:13:09 INFO - Running post-action listener: _resource_record_post_action 04:13:09 INFO - Running post-action listener: _start_resource_monitoring 04:13:09 INFO - Starting resource monitoring. 04:13:09 INFO - ##### 04:13:09 INFO - ##### Finished create-virtualenv step (success) 04:13:09 INFO - ##### 04:13:09 INFO - ##### 04:13:09 INFO - ##### Running install step. 04:13:09 INFO - ##### 04:13:09 INFO - Running pre-action listener: _resource_record_pre_action 04:13:09 INFO - Running main action method: install 04:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:09 INFO - Reading from file tmpfile_stdout 04:13:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:10 INFO - Reading from file tmpfile_stdout 04:13:10 INFO - Output received: 04:13:10 INFO - Usage: mozinstall [options] installer 04:13:10 INFO - Options: 04:13:10 INFO - -h, --help show this help message and exit 04:13:10 INFO - -d DEST, --destination=DEST 04:13:10 INFO - Directory to install application into. [default: 04:13:10 INFO - "/builds/slave/test"] 04:13:10 INFO - --app=APP Application being installed. [default: firefox] 04:13:10 INFO - mkdir: /builds/slave/test/build/application 04:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:26 INFO - Reading from file tmpfile_stdout 04:13:26 INFO - Output received: 04:13:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:26 INFO - Running post-action listener: _resource_record_post_action 04:13:26 INFO - ##### 04:13:26 INFO - ##### Finished install step (success) 04:13:26 INFO - ##### 04:13:26 INFO - ##### 04:13:26 INFO - ##### Running run-tests step. 04:13:26 INFO - ##### 04:13:26 INFO - Running pre-action listener: _resource_record_pre_action 04:13:26 INFO - Running main action method: run_tests 04:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:26 INFO - Python 2.7.3 04:13:26 INFO - Return code: 0 04:13:26 INFO - grabbing minidump binary from tooltool 04:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:26 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 0x26b6110>, '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 0x2622230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26226c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:26 INFO - Return code: 0 04:13:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:13:27 INFO - Return code: 0 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 04:13:28 INFO - mozversion application_buildid: 20160604013006 04:13:28 INFO - mozversion application_changeset: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 04:13:28 INFO - mozversion application_display_name: Nightly 04:13:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:28 INFO - mozversion application_name: Firefox 04:13:28 INFO - mozversion application_remotingname: firefox 04:13:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:13:28 INFO - mozversion application_vendor: Mozilla 04:13:28 INFO - mozversion application_version: 49.0a1 04:13:28 INFO - mozversion platform_buildid: 20160604013006 04:13:28 INFO - mozversion platform_changeset: f3740cfc4b04fb61a1da306df4b1c2437f6bfb65 04:13:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:13:28 INFO - mozversion platform_version: 49.0a1 04:13:28 INFO - using testdate: 1465038808 04:13:28 INFO - actual date: 1465038808 04:13:28 INFO - starting webserver on 'localhost:44244' 04:13:28 INFO - SUITE-START | Running 2 tests 04:13:28 INFO - TEST-START | dromaeo_css 04:13:28 INFO - operating with platform_type : linux_ 04:13:28 INFO - Initialising browser for dromaeo_css test... 04:13:28 INFO - TEST-INFO | started process 10035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67S2Rt/profile http://localhost:44244/getInfo.html) 04:13:32 INFO - PROCESS | 10035 | __metrics Screen width/height:1600/1200 04:13:32 INFO - PROCESS | 10035 | colorDepth:24 04:13:32 INFO - PROCESS | 10035 | Browser inner width/height: 1024/697 04:13:32 INFO - PROCESS | 10035 | __metrics 04:13:33 ERROR - PROCESS | 10035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:13:34 INFO - TEST-INFO | 10035: exit 0 04:13:34 INFO - Browser initialized. 04:13:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:34 INFO - TEST-INFO | started process 10153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67S2Rt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:46 INFO - PROCESS | 10153 | RSS: Main: 167137280 04:13:46 INFO - PROCESS | 10153 | 04:14:35 INFO - PROCESS | 10153 | 1465038875591 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:16:43 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44244/tests/dromaeo/cssquery-ext.html) 04:16:44 INFO - PROCESS | 10153 | RSS: Main: 170995712 04:16:44 INFO - PROCESS | 10153 | 04:19:46 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-ext.html (next: http://localhost:44244/tests/dromaeo/cssquery-jquery.html) 04:19:47 INFO - PROCESS | 10153 | RSS: Main: 169926656 04:19:47 INFO - PROCESS | 10153 | 04:22:49 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44244/tests/dromaeo/cssquery-mootools.html) 04:22:49 INFO - PROCESS | 10153 | RSS: Main: 171053056 04:22:49 INFO - PROCESS | 10153 | 04:25:51 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44244/tests/dromaeo/cssquery-prototype.html) 04:25:52 INFO - PROCESS | 10153 | RSS: Main: 169340928 04:25:52 INFO - PROCESS | 10153 | 04:28:54 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44244/tests/dromaeo/cssquery-yui.html) 04:28:55 INFO - PROCESS | 10153 | RSS: Main: 170934272 04:28:55 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:44244/tests/dromaeo/cssquery-yui.html (next: http://localhost:44244/tests/dromaeo/cssquery-dojo.html) 04:31:58 INFO - PROCESS | 10153 | RSS: Main: 172003328 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | __start_tp_report 04:31:58 INFO - PROCESS | 10153 | _x_x_mozilla_page_load 04:31:58 INFO - PROCESS | 10153 | _x_x_mozilla_page_load_details 04:31:58 INFO - PROCESS | 10153 | |i|pagename|runs| 04:31:58 INFO - PROCESS | 10153 | |0;dojo.html;3129.280265538926;3190.2183964928595;3200.8719651213946;3220.5491231227634;3227.4836026235794;5527.778888844441;5565.721713914303;5571.359293681223;5611.915821262684;5640.266765320513;5459.645123066998;5538.196961440589;5577.470140336662;5609.186667933147;5616.354119276284;4962.305277261177;5057;5175.171972484403;5195.246689230059;5233.398159211702;843.7015816704329;4929.285253638221;5041.621878359119;5061.215511595708;5075.974620126913;5055.898882022376;5073.289739436482;5076.289319495292;5113.463086375933;5114.820981265657;5117.744112794346;5118.667286626357;5121.078205922932;5135.152699804527;5148.742562871879;4941.061198372297;5001.724905130216;5042.596592272646;5064.949350506485;5066.265391518209;5460.535854452376;5460.808871689512;5465.125579907235;5502.9174562381595;5526.944730552683;5796.420357964212;5832.096025116071;6003.519718422515;6039;6041.093835924603;5920.437558431942;5979.880402391971;6015.879682406327;6066.908996365058;6073.058675905242;5639.605227634067;5654.886902261932;5655.575831812631;5660.094384898396;5671.432856714337;5906.9072221639135;6042.486388656926;6149.84625384369;6161.353057928943;6181.7527298908435;5836.533077353886;5895.145203945404;5906.616069955439;5924.555658325643;5960.761569537257;5973.014452615356;5990.460858522754;6001.579889407787;6004.189434426296;6012.338642749294;5643.633163844337;5831.2127862738835;5860.794872179454;5962.105684147413;5965.701714914237;5902.76388944446;5937.168796368512;5939.970300148471;5943.257092863392;5970.044792833126;4513.458384993822;4531.909361812811;4539.024109816405;4542.068875880436;4581.496035436099;3924.50943632046;4005.839766409311;4014.7189696721534;4033.8386464541677;4038.353863381845;5578.497935185853;5597.076482380443;5603.523700485504;5625.690587017753;5638.210650508932;6030.668313242726;6043.879122417615;6051.092336149525;6053.213082299361;6061.181740465069;5515.365732940683;5571.860703482364;5580.832575022756;5646.745896434588;5649.322081350182;5083.517065878736;5131.692098474029;5144.254083157996;5159.17453207485;5237.292965449616;6154.78458253959;6184.288806787277;6200.3179650238435;6212.72042758077;6221.657808820558;6088.8782224356155;6097.054956481752;6099.024156134997;6101.450869421773;6107.450329470369;5987.910181347196;6071.332153463027;6109.1141784440115;6128.713956802996;6138.447539721446;5879.794207202727;5885.117232415001;5923.318818335774;5939.2575928009;5973.970130149321;5829;6020.367861374492;6028.065649824284;6048.758049677964;6064.332923378337;5799.507041901317;5807.070868660994;5843.532517398683;5899.292084949833;5920.585559010828;5853.122031695109;5902.763889444374;5909.911351329648;5911.497522710446;5916.940830591639;5544.833654990357;5706.514946229617;5792.768289268382;5792.797252096157;5797.333306669787;5851.882962340815;5881.353051164283;5906.291245050449;5915.40845915405;5960.493358064613;5787.334456537552;5789.942100579109;5806.390329015392;5822.76708931655;5835.708214589338 04:31:58 INFO - PROCESS | 10153 | |1;ext.html;580.4311774461028;633.5660072850101;641.8459569703272;649.1398896462189;663.3499170812605;31194.84402577987;34086.82956585217;42112;43299.35050974238;43376.3493547597;44172.337414938804;44223.557764422345;44404.555954440526;44637.33044004343;44771.77614111925;8537.4450660707;8660.783480412978;8670.653173873037;8683.56582170892;8702.695405660803;8735.170158834931;8876.822463550725;8891;8916.331275154356;8916.465012099296;8892.822143557158;8899.866502002475;8907.599158037872;8955.238804701576;8962.193402593764;8862.335324850597;8864;8907.153820387053;8930.776730581754;8942.418742781698;8728.956355218246;8801.163889430558;8808;8828.690995815115;8840.336974726857;41550.792246038574;41574.37638435426;41689.58310416887;41832;41899.7905010476;3588.8385022673783;3608.458731190316;3652.689521390685;3751.662350388478;3772.6793222576116;32417.51373729396;32496.675033249838;32784.50823237653;34099.31801363959;34356;4274.123804620045;4364.54172311909;4402.493713222956;4464.955350446487;4564.771761411949;332254;332315;333142;333822;334204.328978356;57856.421435785946;58109.4189058104;58300;58511.70744146252;58560;35973.28053438917;36617;36685.44971825425;37915.81042094772;38518.80740596335;16176.919115404347;16201.270942807601;16243.675126497405;16262.75605865913;16264.349426023064;12780.169288996185;12914.806277905838;12937.676558086123;12992.545260916011;13015.349232538525;19881.801181988285;19893.701594476093;20042.198312067354;20053;20072;7304.488685791944;7374.520656157332;7412.481126321106;7440.627968601549;7642.7325043623205;959.7600599850037;1066.6053560182781;1109.2346281066039;1115;1150.7065698246893;33181.5139983419;33343.66656333454;33365.66634333674;33601;33878.32243355119;1123.3035517978906;1166.2069792541154;1169.2763920608743;1181.474243961429;1210.1710328425056;17387.826121738875;17435.82564174342;17436.5640858977;17738.556536086442;18360.81639183591;478398;481012;482427;482989;484732;59303.70348148232;59540.70229648911;59556.404435955956;59976;60116.69941650264;1348.9055766096278;1353.2692346132978;1387.6322774464572;1388.5417812121975;1406.4374250299961;32050.519242211853;34098.65901341054;34181.31637367189;34254.65745342515;34286.852391265864;51912.740436299086;52254;52715.47284527259;52911;52958;427484;429583;430717;431051;432200;27638.170854874385;28061.158165255074;28133.296667583476;28206.29484262828;28713.28216794597;49129.75435122802;49633;50010;50437.24344134767;50518.49481505138;41773.95565110897;42530.14939701251;42896;42964.14071718611;43709.12581748283;41498.1700365997;42384.364234537126;42564.55120353988;42795.35806962836;42857.57142428661;36982.63017369792;41281.1743765117;41396;41827.58172418237;42055.57944420516;35747;38298.42552361773;38380.950008718406;38451;38708.80645596754;28623.284417888888;28944.42111157723;29002.56496152517;29013;29016.419671606873 04:31:58 INFO - PROCESS | 10153 | |2;jquery.html;383.6700437623644;389.9239648268589;392.7466783924368;394.65029598772196;405.88838069530874;13768.793468097962;18388.90805545972;19092.5226869328;20084.69872951907;20086.397408077744;18120.81879181208;18311.08444577769;18581.628367432644;18945.242190312372;19014;5484.478974497416;5646.858828529279;5716.1425786131995;7065.752698655548;7501.13736920253;7276.345128938395;7372.152202496701;7411.48119631626;7417.925820741804;7421.703131874719;6690.264070952191;6978.057962175092;7020.3681668649815;7102.502824802266;7121.2878712128895;6906.482013848957;7405.074365704287;7428.9257107428775;7467.962660186691;7472.476926615139;6444.677766111676;6791.388775010273;6850.760223392157;7151.964240178818;7194.892076618855;18669.719954200562;23432.64851027236;25275.74724252771;26517.469650607072;26678.333041674112;2172.891355432222;2286.8399212055165;2341.976580234193;2400.7996001999;2437.4515733959893;15734.370625174979;15822.841771582367;15929.28318225671;16242.75635865463;16263.18684065792;2064.700618410322;2163.8052575268302;2218.811401030914;2232.4307301637978;2233.2853486884205;88787;88995.55502222512;89998;92228.53885730596;94160;16237.51287461378;17727.645447090985;17928.193231304624;17938.013409262618;18449.5387615308;31305.530417043763;31569;31629.051128466184;31738.619603529827;31759.364812703618;9025.23285520725;9205.907940920504;9552.761180970532;9612.75968100803;9824.65613703517;7826.686932522635;7919.604019798987;7982.560959147303;8043.638036288381;8044.879326810103;8712.433691810013;8953.462792232487;8971.147740964598;9011.684591039282;9110.453372797654;3546.7517273790586;3601.5318008659233;3606.6753992140834;3682.3187710273687;3705.6479634434686;862.1637012098255;980.4019548075668;1031.9329243599143;1075.983860242097;1095.895889890459;19110.2355905765;19296;20867.269645562636;20891.724829502422;20998.790012099988;973.1144658360857;1054.6730513540826;1058.25921854702;1096.5394534295615;1144.5650652752067;10765.89234107649;11162.441877906072;11165.83251251232;11174.66476005721;11203.71990700239;440389;441330;441521;444342;451272;85158;85474;85623;88820;88888.5555572218;1056.0812093478723;1057.8889216632142;1071.3197119828965;1074.1621535202555;1104.3705088099866;17227;17283.308667653153;17449.214785334436;17476.30094796245;17485.562860928578;39414.605853941095;39990;40172.598274018055;40655.7967210162;44244.33633495436;60282;61230.693846530485;62193;62413.375866240756;62496.375036249054;7619.504732192389;7735.149133595412;8295.62669679878;8307.543085130375;8609.225169734504;13061.34693265314;13489.325533723471;13634.659133521345;13666.316684165553;13674.93162534181;11336.94331528337;11466.770664586495;11769.705757356134;11836.70408239801;11877.881221187678;5450.509454149145;10614.150867930393;11409.828852567052;11470.935231658048;11613.303201807581;11643.417829108681;11865.228760130563;12091.516339346328;12159.939200303941;12627.93686031564;8482.533460659723;8818.603162857815;8821.691240806542;8912;8945.821083578423;11762.411879406167;12055.879441205476;12067.81898271509;12227.266364018187;12310.446029928495 04:31:58 INFO - PROCESS | 10153 | |3;mootools.html;1479.7780332950053;1509.7131545006448;1660.6761681472117;1788.1148831328494;1804.521801722543;7884.369250459964;8915.465072095663;9078.773030674236;9385.483798391086;9399.389039712414;8948.32887533436;9215.769605759859;9286.953565232181;9319.673811416586;9322.720318390458;2353.1528649686097;2393.4614711689906;2394.832361734679;2395.3652282145244;2395.377201927494;2358.740538540759;2374.3351861478814;2376.8217383696206;2385.950181919958;2386.3795413192606;2337.1819863047967;2341.180586794617;2351.200591798788;2358.056777289081;2375.798057165143;2279.8632082075046;2300.1144559344607;2305.804006659436;2314.2941402872116;2322.384568089449;2309.261036468331;2309.388012176758;2311.0871205873586;2336.1823361823394;2346.343023953296;9090.363674542785;9137.771555711093;9143.994160642324;9208.815823683488;9209.769755756093;5274.2879711238875;5373.247745315659;5374.946250537484;5413.458654134555;5419.864503387407;3323.88366407177;3388.8644454221803;3389.9322013559836;3398.2523844754114;3461.8615255389755;1069.9625513107003;1082.242430298794;1083.7507373304184;1084.203110713625;1099.912007039435;12856.55002074923;12858.485660573566;12880.742385152245;12894.871051289461;12974.80537791934;4552.430946131733;4612.561806628432;4699.895524551727;4717.292406139107;4740.881477963078;10692.786144277226;10732.195085368628;10739.409332486632;10781.02970732638;10791.24461287718;5294.655847369909;5408.648437851606;5415.160650099241;5416.052190866582;5417.945820541823;4257.63810076147;4841.564259216688;4936.617747030838;4957;4977.626677999165;4034.2133284009337;4059.3505039193587;4079.63283304504;4099.61053699898;4123.326739283028;1248.581725122076;1250.637315178588;1254.6549698832712;1278.4758249117817;1282.5959822655834;1033.679559336593;1041.1878734587035;1047.3297089862494;1063.8882917293727;1065.2436769893463;6357.823802596442;6369.14016607752;6392.232932048091;6411.519136064814;6560.081588577603;433.8156283579466;439.38266735237045;446.09442831053013;448.6007453366506;449.1398970970555;4401.471823381215;4496.887577810581;4538.546145385435;4563.041761230113;4568.246239370533;11109.277896936674;11646;11648.88351116495;11649.650510484698;11699.590514331958;10692.786144277072;11116.277441966246;11513.88486115145;11578.71053223676;11584.247023943417;8421.873671894926;8619.655213791379;8628.439151455135;8632.309415246766;8666.566671666518;6129.570930034854;6343.492520598434;6352.968235158794;6409.03864420322;6465.06256592782;10572.101371383518;10617.575296988034;10690.41202733857;10713.142948564253;10736;10073.949630252095;10498.580056797642;10595.258331916692;10808.945955270174;10918;7235.963820180866;7747.496412733154;7797.883031754642;7802;8106.229908158715;9017.909820901707;9049.095090490899;9066.546672666473;9119.316051296046;9157.542122893696;7947.086085100287;8111.351091912515;8292.917070829215;8397.244248017463;8398;8026.43814932949;8085.8787118192095;8188.2630563249595;8200.671973121247;8222.465539739898;7040.718371265092;7129.500934934505;7267.0552828132;7282.67227974753;7321.158066822383;5448.4006759257245;5500.614956952975;5511.145772405283;5593.133064375028;5631.324241091095;5390.598444404404;5449.455054494519;5493.285872836505;5537.280153580009;5611.719414029364 04:31:58 INFO - PROCESS | 10153 | |4;prototype.html;310.1378168691037;310.5404002076926;312.8545226469691;317.93641271745656;318.644711147071;5676.460736230062;5734.655920644765;5767.567432442573;5788.768449262035;5796.855078623036;5585.748641311141;5586.597762961935;5588.944110558893;5621.173118736417;5639.449151483344;4147.502299724038;4201.991522034705;4343.913121737563;4361.520232774392;4381.474223093233;4354.847580334673;4357.259265924785;4366.716163449381;4385.407969924051;4389.7146685465505;4363.974466000487;4370.628496577795;4379.868603941887;4394.07724377881;4396.912061758763;4299.269124248885;4345.174416860802;4354.673399495051;4368.453943257093;4379.5182529921685;3790.2564820182747;3813.180166264239;3826.598207188261;3834.69322454203;3836.8848934532007;5438.564914806806;5442.809501667422;5462.945370546284;5474.753636086386;5513.862153446155;4845.491223421525;4918.163912134945;5014.24786282057;5015.22264049073;5035.546800787946;5787.305523337226;5808.809194115196;5857.589968702193;5893.970530147365;5909.936211481931;4173.31140361843;4201.873943781691;4210.305299625558;4221.134667393177;4223.282042052859;5903.763849446017;6218.502519798405;6273.215848018997;6283.340249273806;6290.591111577779;4118.258713431611;4134.945588874818;4144.772037537964;4149.439825623563;4163.458750362433;4193.790310484464;4212.599803018708;4226.197022565702;4231.555686652919;4231.576842315744;4797.2564252540915;4942.629302802305;4961.479044700327;4963.553280204726;4993.051320249214;5945.316288626776;5997.550183736237;6032.969835150796;6057.182280392179;6058.333583305833;1462.6197188730794;1473.0351619688906;1474.1523623916291;1481.7258807120718;1484.406237504985;925.2459245714721;938.6808485115093;985;986.8421052631688;995.9053889880449;5605.523530499953;5621.578381621394;5640;5642.153676948491;5700.629459085229;6006.279246490449;6054.606450580786;6063;6104.664243466652;6138.508919286446;5448.400675925645;5573.024720673866;5656.5757568181725;5659.943400565941;5697.487226149667;3265.48155107876;3271.3130242648836;3274.983625081907;3277.852496637657;3288.638249792521;5973.104034394875;6163.890499710005;6200.3179650238435;6201.782937597162;6276.7090012146155;6146.7233974471255;6157.168782214433;6162.445379915829;6170.382961703794;6177.660228687465;5869.207656966255;6130.846728831815;6170.784022559189;6197.318294987548;6267.4045965633195;5925.970370148294;5994.250718660168;6014.879702406015;6049.667268300285;6065.302490213682;5979.671118088547;5982.521398288213;5984.670843103671;5987.371326010706;5991.502124468882;5986.610870293591;6157.907631385443;6192.752289908533;6211.503079753518;6238.781642642486;4162.229987452331;4162.7502349859105;4188.9162216754885;4198.958010419857;4201.747895126302;5778.335491418373;5984.760609575568;6031.306399763907;6040.2751669798145;6043.395660433922;5895.616784908967;5959.22530071088;5961.850953726192;5978.97010514962;6016.849578760566;5663.1788390682295;5866.530677545701;5888.558358123072;5902.1441890926435;5981;5675.829725108253;5792.94207057924;5795.710214489343;5837.766489340379;5851.64890106595;5855.238818953509;5920.674362910081;5934.347221805684;5940.613860099253;5947.851303717269;5615.6630602164005;5697.718013446941;5777.191193232867;5783.479486846204;5833 04:31:58 INFO - PROCESS | 10153 | |5;yui.html;763.2215140556635;763.6372722956596;777.0869228656328;791.1218547412371;827.797189688526;15514.767278490832;16986.66026679467;17546.561335966606;17643.47069587911;18263.908680456614;16699;16729;16730.330786768543;16778.328866845342;16804.663906721857;672.8082496488502;791.4815795653856;793.6269953122023;795.8487887301394;795.8686816675256;806.9435139540235;823.6005537314397;825.8926339575846;836.1429534726923;837.6523742646825;841.0496139362542;843.3169133002257;852.7825404521839;853.2491407561369;853.5902766672001;845.1379592815356;852.2372476633378;854.2781349759443;854.5727136431784;855.8801767752519;612.7303986246083;618.709206672863;620.872721092175;621.0870021069021;622.0606883605743;15403.07581545111;15441.691166176726;15448.922755386264;15449.613759656098;15458.227088645523;14572.854271457256;14767.630809229855;14877.47928822486;14933.328000240015;14975.625609359744;12448.9248113573;12581.496740130384;12632.49470021198;12727.809082863765;13346;3778.4521244419407;3791.6777073948747;3819;3836.673882719972;3954.8615798446917;72180.27819721788;72433.63783181104;72671.63664181698;73175;73184.63407682981;10728.463576821128;11031.393273369882;11126.499307531181;11280.943595281971;11560.421978901022;20355.592888142153;20539.28112516055;20568.691469627967;20674.069666865027;20702.171913123308;8684.306560220697;8796.736097917073;8807.07525709804;8827.426217295855;8875.600597973107;4707.952920470751;4709.976450117796;4909.337239472697;4918.581920536794;4928.433230178575;3658.817059147032;3889.0471834400755;3908.726389152732;3919.9608003920166;3921.6666583340734;638.419038674813;639.4085470939362;655.1450357283695;663.4824836627438;665.0489799586541;468.8968426946066;684.1277371351566;735.4631119282953;756.8713318735718;785.4658831994185;10287.382757034453;10416.166706663449;10489.580416783396;10552.736181595368;10902.182336324808;610.7434877351523;688.8002479281053;718.8202949262684;789.8933643958107;799.9960000199961;4930.517312376933;5166.741662916839;5167.431582525919;5183.437243846067;5218.478152184751;67379;69384.95922561166;70250.64874675593;88475;113939;43403.131937361075;43957.78021109938;83731.58134209411;94418;99949.00101998064;75752.24247757452;76992.99999999888;89387.55306223557;90060;90792;9716.805663886542;9760.658376956773;9777.608895644094;9886.901130988597;9950;46368.536314636425;51128;51559;51601.48398515967;53278.20082698685;67068.32931670621;73977;75510.24489755032;75970.24029759632;76295.61852190703;13101.67245818824;13101.934490327487;13221.735565288447;13322.134061285986;13499.325033748077;14756.696782374353;14779.334929927963;14855.257237137883;15016.249187540798;15314.463993760164;13338.3330833456;13747.518836840663;13818.792718109034;14109.717805643624;14808;13600;13693.726125477235;13882;14189.07770994882;14750.188739618994;12820.935895320463;13235.27206003679;13661.726765464833;13945.233012184022;13975.860241397455;10686.25196236256;11053.447327633747;11465.31208127515;11615.76768464609;11618.825717614412;10919.727006824574;11234.3259404436;11292.717682058013;11344.376059316817;11507.712307192387 04:31:58 INFO - PROCESS | 10153 | __end_tp_report 04:31:58 INFO - PROCESS | 10153 | __start_cc_report 04:31:58 INFO - PROCESS | 10153 | _x_x_mozilla_cycle_collect,351 04:31:58 INFO - PROCESS | 10153 | __end_cc_report 04:31:58 INFO - PROCESS | 10153 | __startTimestamp1465039918257__endTimestamp 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | ------- Summary: start ------- 04:31:58 INFO - PROCESS | 10153 | Number of tests: 6 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#0] dojo.html Cycles:165 Average:5521.23 Median:5797.33 stddev:740.07 (12.8%) stddev-sans-first:718.15 04:31:58 INFO - PROCESS | 10153 | Values: 3129.3 3190.2 3200.9 3220.5 3227.5 5527.8 5565.7 5571.4 5611.9 5640.3 5459.6 5538.2 5577.5 5609.2 5616.4 4962.3 5057.0 5175.2 5195.2 5233.4 843.7 4929.3 5041.6 5061.2 5076.0 5055.9 5073.3 5076.3 5113.5 5114.8 5117.7 5118.7 5121.1 5135.2 5148.7 4941.1 5001.7 5042.6 5064.9 5066.3 5460.5 5460.8 5465.1 5502.9 5526.9 5796.4 5832.1 6003.5 6039.0 6041.1 5920.4 5979.9 6015.9 6066.9 6073.1 5639.6 5654.9 5655.6 5660.1 5671.4 5906.9 6042.5 6149.8 6161.4 6181.8 5836.5 5895.1 5906.6 5924.6 5960.8 5973.0 5990.5 6001.6 6004.2 6012.3 5643.6 5831.2 5860.8 5962.1 5965.7 5902.8 5937.2 5940.0 5943.3 5970.0 4513.5 4531.9 4539.0 4542.1 4581.5 3924.5 4005.8 4014.7 4033.8 4038.4 5578.5 5597.1 5603.5 5625.7 5638.2 6030.7 6043.9 6051.1 6053.2 6061.2 5515.4 5571.9 5580.8 5646.7 5649.3 5083.5 5131.7 5144.3 5159.2 5237.3 6154.8 6184.3 6200.3 6212.7 6221.7 6088.9 6097.1 6099.0 6101.5 6107.5 5987.9 6071.3 6109.1 6128.7 6138.4 5879.8 5885.1 5923.3 5939.3 5974.0 5829.0 6020.4 6028.1 6048.8 6064.3 5799.5 5807.1 5843.5 5899.3 5920.6 5853.1 5902.8 5909.9 5911.5 5916.9 5544.8 5706.5 5792.8 5792.8 5797.3 5851.9 5881.4 5906.3 5915.4 5960.5 5787.3 5789.9 5806.4 5822.8 5835.7 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#1] ext.html Cycles:180 Average:57776.48 Median:41865.90 stddev:110904.62 (264.9%) stddev-sans-first:111132.60 04:31:58 INFO - PROCESS | 10153 | Values: 580.4 633.6 641.8 649.1 663.3 31194.8 34086.8 42112.0 43299.4 43376.3 44172.3 44223.6 44404.6 44637.3 44771.8 8537.4 8660.8 8670.7 8683.6 8702.7 8735.2 8876.8 8891.0 8916.3 8916.5 8892.8 8899.9 8907.6 8955.2 8962.2 8862.3 8864.0 8907.2 8930.8 8942.4 8729.0 8801.2 8808.0 8828.7 8840.3 41550.8 41574.4 41689.6 41832.0 41899.8 3588.8 3608.5 3652.7 3751.7 3772.7 32417.5 32496.7 32784.5 34099.3 34356.0 4274.1 4364.5 4402.5 4465.0 4564.8 332254.0 332315.0 333142.0 333822.0 334204.3 57856.4 58109.4 58300.0 58511.7 58560.0 35973.3 36617.0 36685.4 37915.8 38518.8 16176.9 16201.3 16243.7 16262.8 16264.3 12780.2 12914.8 12937.7 12992.5 13015.3 19881.8 19893.7 20042.2 20053.0 20072.0 7304.5 7374.5 7412.5 7440.6 7642.7 959.8 1066.6 1109.2 1115.0 1150.7 33181.5 33343.7 33365.7 33601.0 33878.3 1123.3 1166.2 1169.3 1181.5 1210.2 17387.8 17435.8 17436.6 17738.6 18360.8 478398.0 481012.0 482427.0 482989.0 484732.0 59303.7 59540.7 59556.4 59976.0 60116.7 1348.9 1353.3 1387.6 1388.5 1406.4 32050.5 34098.7 34181.3 34254.7 34286.9 51912.7 52254.0 52715.5 52911.0 52958.0 427484.0 429583.0 430717.0 431051.0 432200.0 27638.2 28061.2 28133.3 28206.3 28713.3 49129.8 49633.0 50010.0 50437.2 50518.5 41774.0 42530.1 42896.0 42964.1 43709.1 41498.2 42384.4 42564.6 42795.4 42857.6 36982.6 41281.2 41396.0 41827.6 42055.6 35747.0 38298.4 38381.0 38451.0 38708.8 28623.3 28944.4 29002.6 29013.0 29016.4 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#2] jquery.html Cycles:180 Average:29117.51 Median:17653.06 stddev:73375.82 (415.7%) stddev-sans-first:73549.94 04:31:58 INFO - PROCESS | 10153 | Values: 383.7 389.9 392.7 394.7 405.9 13768.8 18388.9 19092.5 20084.7 20086.4 18120.8 18311.1 18581.6 18945.2 19014.0 5484.5 5646.9 5716.1 7065.8 7501.1 7276.3 7372.2 7411.5 7417.9 7421.7 6690.3 6978.1 7020.4 7102.5 7121.3 6906.5 7405.1 7428.9 7468.0 7472.5 6444.7 6791.4 6850.8 7152.0 7194.9 18669.7 23432.6 25275.7 26517.5 26678.3 2172.9 2286.8 2342.0 2400.8 2437.5 15734.4 15822.8 15929.3 16242.8 16263.2 2064.7 2163.8 2218.8 2232.4 2233.3 88787.0 88995.6 89998.0 92228.5 94160.0 16237.5 17727.6 17928.2 17938.0 18449.5 31305.5 31569.0 31629.1 31738.6 31759.4 9025.2 9205.9 9552.8 9612.8 9824.7 7826.7 7919.6 7982.6 8043.6 8044.9 8712.4 8953.5 8971.1 9011.7 9110.5 3546.8 3601.5 3606.7 3682.3 3705.6 862.2 980.4 1031.9 1076.0 1095.9 19110.2 19296.0 20867.3 20891.7 20998.8 973.1 1054.7 1058.3 1096.5 1144.6 10765.9 11162.4 11165.8 11174.7 11203.7 440389.0 441330.0 441521.0 444342.0 451272.0 85158.0 85474.0 85623.0 88820.0 88888.6 1056.1 1057.9 1071.3 1074.2 1104.4 17227.0 17283.3 17449.2 17476.3 17485.6 39414.6 39990.0 40172.6 40655.8 44244.3 60282.0 61230.7 62193.0 62413.4 62496.4 7619.5 7735.1 8295.6 8307.5 8609.2 13061.3 13489.3 13634.7 13666.3 13674.9 11336.9 11466.8 11769.7 11836.7 11877.9 5450.5 10614.2 11409.8 11470.9 11613.3 11643.4 11865.2 12091.5 12159.9 12627.9 8482.5 8818.6 8821.7 8912.0 8945.8 11762.4 12055.9 12067.8 12227.3 12310.4 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#3] mootools.html Cycles:180 Average:6035.22 Median:448.87 stddev:3492.79 (778.1%) stddev-sans-first:3485.81 04:31:58 INFO - PROCESS | 10153 | Values: 1479.8 1509.7 1660.7 1788.1 1804.5 7884.4 8915.5 9078.8 9385.5 9399.4 8948.3 9215.8 9287.0 9319.7 9322.7 2353.2 2393.5 2394.8 2395.4 2395.4 2358.7 2374.3 2376.8 2386.0 2386.4 2337.2 2341.2 2351.2 2358.1 2375.8 2279.9 2300.1 2305.8 2314.3 2322.4 2309.3 2309.4 2311.1 2336.2 2346.3 9090.4 9137.8 9144.0 9208.8 9209.8 5274.3 5373.2 5374.9 5413.5 5419.9 3323.9 3388.9 3389.9 3398.3 3461.9 1070.0 1082.2 1083.8 1084.2 1099.9 12856.6 12858.5 12880.7 12894.9 12974.8 4552.4 4612.6 4699.9 4717.3 4740.9 10692.8 10732.2 10739.4 10781.0 10791.2 5294.7 5408.6 5415.2 5416.1 5417.9 4257.6 4841.6 4936.6 4957.0 4977.6 4034.2 4059.4 4079.6 4099.6 4123.3 1248.6 1250.6 1254.7 1278.5 1282.6 1033.7 1041.2 1047.3 1063.9 1065.2 6357.8 6369.1 6392.2 6411.5 6560.1 433.8 439.4 446.1 448.6 449.1 4401.5 4496.9 4538.5 4563.0 4568.2 11109.3 11646.0 11648.9 11649.7 11699.6 10692.8 11116.3 11513.9 11578.7 11584.2 8421.9 8619.7 8628.4 8632.3 8666.6 6129.6 6343.5 6353.0 6409.0 6465.1 10572.1 10617.6 10690.4 10713.1 10736.0 10073.9 10498.6 10595.3 10808.9 10918.0 7236.0 7747.5 7797.9 7802.0 8106.2 9017.9 9049.1 9066.5 9119.3 9157.5 7947.1 8111.4 8292.9 8397.2 8398.0 8026.4 8085.9 8188.3 8200.7 8222.5 7040.7 7129.5 7267.1 7282.7 7321.2 5448.4 5500.6 5511.1 5593.1 5631.3 5390.6 5449.5 5493.3 5537.3 5611.7 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#4] prototype.html Cycles:180 Average:4943.16 Median:5676.15 stddev:1472.39 (25.9%) stddev-sans-first:1434.87 04:31:58 INFO - PROCESS | 10153 | Values: 310.1 310.5 312.9 317.9 318.6 5676.5 5734.7 5767.6 5788.8 5796.9 5585.7 5586.6 5588.9 5621.2 5639.4 4147.5 4202.0 4343.9 4361.5 4381.5 4354.8 4357.3 4366.7 4385.4 4389.7 4364.0 4370.6 4379.9 4394.1 4396.9 4299.3 4345.2 4354.7 4368.5 4379.5 3790.3 3813.2 3826.6 3834.7 3836.9 5438.6 5442.8 5462.9 5474.8 5513.9 4845.5 4918.2 5014.2 5015.2 5035.5 5787.3 5808.8 5857.6 5894.0 5909.9 4173.3 4201.9 4210.3 4221.1 4223.3 5903.8 6218.5 6273.2 6283.3 6290.6 4118.3 4134.9 4144.8 4149.4 4163.5 4193.8 4212.6 4226.2 4231.6 4231.6 4797.3 4942.6 4961.5 4963.6 4993.1 5945.3 5997.6 6033.0 6057.2 6058.3 1462.6 1473.0 1474.2 1481.7 1484.4 925.2 938.7 985.0 986.8 995.9 5605.5 5621.6 5640.0 5642.2 5700.6 6006.3 6054.6 6063.0 6104.7 6138.5 5448.4 5573.0 5656.6 5659.9 5697.5 3265.5 3271.3 3275.0 3277.9 3288.6 5973.1 6163.9 6200.3 6201.8 6276.7 6146.7 6157.2 6162.4 6170.4 6177.7 5869.2 6130.8 6170.8 6197.3 6267.4 5926.0 5994.3 6014.9 6049.7 6065.3 5979.7 5982.5 5984.7 5987.4 5991.5 5986.6 6157.9 6192.8 6211.5 6238.8 4162.2 4162.8 4188.9 4199.0 4201.7 5778.3 5984.8 6031.3 6040.3 6043.4 5895.6 5959.2 5961.9 5979.0 6016.8 5663.2 5866.5 5888.6 5902.1 5981.0 5675.8 5792.9 5795.7 5837.8 5851.6 5855.2 5920.7 5934.3 5940.6 5947.9 5615.7 5697.7 5777.2 5783.5 5833.0 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - PROCESS | 10153 | [#5] yui.html Cycles:180 Average:19204.13 Median:4708.96 stddev:25654.49 (544.8%) stddev-sans-first:25689.08 04:31:58 INFO - PROCESS | 10153 | Values: 763.2 763.6 777.1 791.1 827.8 15514.8 16986.7 17546.6 17643.5 18263.9 16699.0 16729.0 16730.3 16778.3 16804.7 672.8 791.5 793.6 795.8 795.9 806.9 823.6 825.9 836.1 837.7 841.0 843.3 852.8 853.2 853.6 845.1 852.2 854.3 854.6 855.9 612.7 618.7 620.9 621.1 622.1 15403.1 15441.7 15448.9 15449.6 15458.2 14572.9 14767.6 14877.5 14933.3 14975.6 12448.9 12581.5 12632.5 12727.8 13346.0 3778.5 3791.7 3819.0 3836.7 3954.9 72180.3 72433.6 72671.6 73175.0 73184.6 10728.5 11031.4 11126.5 11280.9 11560.4 20355.6 20539.3 20568.7 20674.1 20702.2 8684.3 8796.7 8807.1 8827.4 8875.6 4708.0 4710.0 4909.3 4918.6 4928.4 3658.8 3889.0 3908.7 3920.0 3921.7 638.4 639.4 655.1 663.5 665.0 468.9 684.1 735.5 756.9 785.5 10287.4 10416.2 10489.6 10552.7 10902.2 610.7 688.8 718.8 789.9 800.0 4930.5 5166.7 5167.4 5183.4 5218.5 67379.0 69385.0 70250.6 88475.0 113939.0 43403.1 43957.8 83731.6 94418.0 99949.0 75752.2 76993.0 89387.6 90060.0 90792.0 9716.8 9760.7 9777.6 9886.9 9950.0 46368.5 51128.0 51559.0 51601.5 53278.2 67068.3 73977.0 75510.2 75970.2 76295.6 13101.7 13101.9 13221.7 13322.1 13499.3 14756.7 14779.3 14855.3 15016.2 15314.5 13338.3 13747.5 13818.8 14109.7 14808.0 13600.0 13693.7 13882.0 14189.1 14750.2 12820.9 13235.3 13661.7 13945.2 13975.9 10686.3 11053.4 11465.3 11615.8 11618.8 10919.7 11234.3 11292.7 11344.4 11507.7 04:31:58 INFO - PROCESS | 10153 | -------- Summary: end -------- 04:31:58 INFO - PROCESS | 10153 | 04:31:58 INFO - TEST-INFO | 10153: exit 0 04:31:58 INFO - TEST-OK | dromaeo_css | took 1110944ms 04:31:58 INFO - TEST-START | kraken 04:31:58 INFO - operating with platform_type : linux_ 04:31:58 INFO - Initialising browser for kraken test... 04:31:58 INFO - TEST-INFO | started process 10395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6cS0z/profile http://localhost:44244/getInfo.html) 04:32:03 INFO - PROCESS | 10395 | __metrics Screen width/height:1600/1200 04:32:03 INFO - PROCESS | 10395 | colorDepth:24 04:32:03 INFO - PROCESS | 10395 | Browser inner width/height: 1024/697 04:32:03 INFO - PROCESS | 10395 | __metrics 04:32:04 ERROR - PROCESS | 10395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:32:05 INFO - TEST-INFO | 10395: exit 0 04:32:05 INFO - Browser initialized. 04:32:05 INFO - Running cycle 1/1 for kraken test... 04:32:05 INFO - TEST-INFO | started process 10512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6cS0z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:16 INFO - PROCESS | 10512 | RSS: Main: 167526400 04:32:16 INFO - PROCESS | 10512 | 04:32:19 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44244/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:20 INFO - PROCESS | 10512 | RSS: Main: 172400640 04:32:20 INFO - PROCESS | 10512 | 04:32:22 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44244/tests/kraken/driver.html?testName=audio-dft) 04:32:23 INFO - PROCESS | 10512 | RSS: Main: 171683840 04:32:23 INFO - PROCESS | 10512 | 04:32:26 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44244/tests/kraken/driver.html?testName=audio-fft) 04:32:27 INFO - PROCESS | 10512 | RSS: Main: 166957056 04:32:27 INFO - PROCESS | 10512 | 04:32:29 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44244/tests/kraken/driver.html?testName=audio-oscillator) 04:32:29 INFO - PROCESS | 10512 | RSS: Main: 167530496 04:32:29 INFO - PROCESS | 10512 | 04:32:31 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:32 INFO - PROCESS | 10512 | RSS: Main: 167809024 04:32:32 INFO - PROCESS | 10512 | 04:32:35 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44244/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:36 INFO - PROCESS | 10512 | RSS: Main: 167534592 04:32:36 INFO - PROCESS | 10512 | 04:32:39 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44244/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:40 INFO - PROCESS | 10512 | RSS: Main: 168620032 04:32:40 INFO - PROCESS | 10512 | 04:32:43 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44244/tests/kraken/driver.html?testName=json-parse-financial) 04:32:43 INFO - PROCESS | 10512 | RSS: Main: 168779776 04:32:43 INFO - PROCESS | 10512 | 04:32:45 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:46 INFO - PROCESS | 10512 | RSS: Main: 168726528 04:32:46 INFO - PROCESS | 10512 | 04:32:47 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:48 INFO - PROCESS | 10512 | RSS: Main: 168947712 04:32:48 INFO - PROCESS | 10512 | 04:32:50 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:51 INFO - PROCESS | 10512 | RSS: Main: 169046016 04:32:51 INFO - PROCESS | 10512 | 04:32:53 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:54 INFO - PROCESS | 10512 | RSS: Main: 169259008 04:32:54 INFO - PROCESS | 10512 | 04:32:57 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:57 INFO - PROCESS | 10512 | RSS: Main: 169132032 04:32:57 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | Cycle 1(1): loaded http://localhost:44244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44244/tests/kraken/driver.html?testName=ai-astar) 04:32:59 INFO - PROCESS | 10512 | RSS: Main: 169824256 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | __start_tp_report 04:32:59 INFO - PROCESS | 10512 | _x_x_mozilla_page_load 04:32:59 INFO - PROCESS | 10512 | _x_x_mozilla_page_load_details 04:32:59 INFO - PROCESS | 10512 | |i|pagename|runs| 04:32:59 INFO - PROCESS | 10512 | |0;ai-astar;114;105;111;111;111;112;111;111;111;110 04:32:59 INFO - PROCESS | 10512 | |1;audio-beat-detection;154;124;153;180;127;151;157;127;180;125 04:32:59 INFO - PROCESS | 10512 | |2;audio-dft;161;162;163;161;162;163;175;164;162;163 04:32:59 INFO - PROCESS | 10512 | |3;audio-fft;74;77;76;167;75;76;74;76;180;75 04:32:59 INFO - PROCESS | 10512 | |4;audio-oscillator;85;85;137;85;85;84;137;84;84;145 04:32:59 INFO - PROCESS | 10512 | |5;imaging-gaussian-blur;117;117;118;118;117;118;117;117;117;117 04:32:59 INFO - PROCESS | 10512 | |6;imaging-darkroom;146;146;146;146;147;147;147;148;146;145 04:32:59 INFO - PROCESS | 10512 | |7;imaging-desaturate;96;97;95;95;97;96;95;96;95;96 04:32:59 INFO - PROCESS | 10512 | |8;json-parse-financial;64;56;59;55;55;55;58;55;58;55 04:32:59 INFO - PROCESS | 10512 | |9;json-stringify-tinderbox;62;63;62;63;62;63;62;62;62;62 04:32:59 INFO - PROCESS | 10512 | |10;stanford-crypto-aes;83;78;79;80;83;81;79;81;110;79 04:32:59 INFO - PROCESS | 10512 | |11;stanford-crypto-ccm;125;123;122;131;128;123;133;133;136;120 04:32:59 INFO - PROCESS | 10512 | |12;stanford-crypto-pbkdf2;160;163;162;163;159;158;163;164;158;159 04:32:59 INFO - PROCESS | 10512 | |13;stanford-crypto-sha256-iterative;62;74;66;69;62;65;62;62;65;62 04:32:59 INFO - PROCESS | 10512 | __end_tp_report 04:32:59 INFO - PROCESS | 10512 | __start_cc_report 04:32:59 INFO - PROCESS | 10512 | _x_x_mozilla_cycle_collect,893 04:32:59 INFO - PROCESS | 10512 | __end_cc_report 04:32:59 INFO - PROCESS | 10512 | __startTimestamp1465039979656__endTimestamp 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | ------- Summary: start ------- 04:32:59 INFO - PROCESS | 10512 | Number of tests: 14 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.06 04:32:59 INFO - PROCESS | 10512 | Values: 114.0 105.0 111.0 111.0 111.0 112.0 111.0 111.0 111.0 110.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.50 stddev:21.57 (14.0%) stddev-sans-first:22.76 04:32:59 INFO - PROCESS | 10512 | Values: 154.0 124.0 153.0 180.0 127.0 151.0 157.0 127.0 180.0 125.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:4.12 (2.5%) stddev-sans-first:4.26 04:32:59 INFO - PROCESS | 10512 | Values: 161.0 162.0 163.0 161.0 162.0 163.0 175.0 164.0 162.0 163.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:41.50 (55.0%) stddev-sans-first:43.31 04:32:59 INFO - PROCESS | 10512 | Values: 74.0 77.0 76.0 167.0 75.0 76.0 74.0 76.0 180.0 75.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:84.50 stddev:26.71 (31.6%) stddev-sans-first:27.68 04:32:59 INFO - PROCESS | 10512 | Values: 85.0 85.0 137.0 85.0 85.0 84.0 137.0 84.0 84.0 145.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:32:59 INFO - PROCESS | 10512 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 04:32:59 INFO - PROCESS | 10512 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 145.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:32:59 INFO - PROCESS | 10512 | Values: 96.0 97.0 95.0 95.0 97.0 96.0 95.0 96.0 95.0 96.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:1.64 04:32:59 INFO - PROCESS | 10512 | Values: 64.0 56.0 59.0 55.0 55.0 55.0 58.0 55.0 58.0 55.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:32:59 INFO - PROCESS | 10512 | Values: 62.0 63.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 62.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.50 stddev:9.53 (11.8%) stddev-sans-first:10.11 04:32:59 INFO - PROCESS | 10512 | Values: 83.0 78.0 79.0 80.0 83.0 81.0 79.0 81.0 110.0 79.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.50 stddev:5.56 (4.3%) stddev-sans-first:5.83 04:32:59 INFO - PROCESS | 10512 | Values: 125.0 123.0 122.0 131.0 128.0 123.0 133.0 133.0 136.0 120.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.50 stddev:2.33 (1.4%) stddev-sans-first:2.45 04:32:59 INFO - PROCESS | 10512 | Values: 160.0 163.0 162.0 163.0 159.0 158.0 163.0 164.0 158.0 159.0 04:32:59 INFO - PROCESS | 10512 | 04:32:59 INFO - PROCESS | 10512 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:3.98 (6.1%) stddev-sans-first:4.09 04:32:59 INFO - PROCESS | 10512 | Values: 62.0 74.0 66.0 69.0 62.0 65.0 62.0 62.0 65.0 62.0 04:32:59 INFO - PROCESS | 10512 | -------- Summary: end -------- 04:32:59 INFO - PROCESS | 10512 | 04:33:00 INFO - TEST-INFO | 10512: exit 0 04:33:00 INFO - TEST-OK | kraken | took 61581ms 04:33:00 INFO - SUITE-END | took 1172s 04:33:00 INFO - Completed test suite (00:19:32) 04:33:00 INFO - javascript benchmark 04:33:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7521.675699445876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.280265538926, 3190.2183964928595, 3200.8719651213946, 3220.5491231227634, 3227.4836026235794, 5527.778888844441, 5565.721713914303, 5571.359293681223, 5611.915821262684, 5640.266765320513, 5459.645123066998, 5538.196961440589, 5577.470140336662, 5609.186667933147, 5616.354119276284, 4962.305277261177, 5057.0, 5175.171972484403, 5195.246689230059, 5233.398159211702, 843.7015816704329, 4929.285253638221, 5041.621878359119, 5061.215511595708, 5075.974620126913, 5055.898882022376, 5073.289739436482, 5076.289319495292, 5113.463086375933, 5114.820981265657, 5117.744112794346, 5118.667286626357, 5121.078205922932, 5135.152699804527, 5148.742562871879, 4941.061198372297, 5001.724905130216, 5042.596592272646, 5064.949350506485, 5066.265391518209, 5460.535854452376, 5460.808871689512, 5465.125579907235, 5502.9174562381595, 5526.944730552683, 5796.420357964212, 5832.096025116071, 6003.519718422515, 6039.0, 6041.093835924603, 5920.437558431942, 5979.880402391971, 6015.879682406327, 6066.908996365058, 6073.058675905242, 5639.605227634067, 5654.886902261932, 5655.575831812631, 5660.094384898396, 5671.432856714337, 5906.9072221639135, 6042.486388656926, 6149.84625384369, 6161.353057928943, 6181.7527298908435, 5836.533077353886, 5895.145203945404, 5906.616069955439, 5924.555658325643, 5960.761569537257, 5973.014452615356, 5990.460858522754, 6001.579889407787, 6004.189434426296, 6012.338642749294, 5643.633163844337, 5831.2127862738835, 5860.794872179454, 5962.105684147413, 5965.701714914237, 5902.76388944446, 5937.168796368512, 5939.970300148471, 5943.257092863392, 5970.044792833126, 4513.458384993822, 4531.909361812811, 4539.024109816405, 4542.068875880436, 4581.496035436099, 3924.50943632046, 4005.839766409311, 4014.7189696721534, 4033.8386464541677, 4038.353863381845, 5578.497935185853, 5597.076482380443, 5603.523700485504, 5625.690587017753, 5638.210650508932, 6030.668313242726, 6043.879122417615, 6051.092336149525, 6053.213082299361, 6061.181740465069, 5515.365732940683, 5571.860703482364, 5580.832575022756, 5646.745896434588, 5649.322081350182, 5083.517065878736, 5131.692098474029, 5144.254083157996, 5159.17453207485, 5237.292965449616, 6154.78458253959, 6184.288806787277, 6200.3179650238435, 6212.72042758077, 6221.657808820558, 6088.8782224356155, 6097.054956481752, 6099.024156134997, 6101.450869421773, 6107.450329470369, 5987.910181347196, 6071.332153463027, 6109.1141784440115, 6128.713956802996, 6138.447539721446, 5879.794207202727, 5885.117232415001, 5923.318818335774, 5939.2575928009, 5973.970130149321, 5829.0, 6020.367861374492, 6028.065649824284, 6048.758049677964, 6064.332923378337, 5799.507041901317, 5807.070868660994, 5843.532517398683, 5899.292084949833, 5920.585559010828, 5853.122031695109, 5902.763889444374, 5909.911351329648, 5911.497522710446, 5916.940830591639, 5544.833654990357, 5706.514946229617, 5792.768289268382, 5792.797252096157, 5797.333306669787, 5851.882962340815, 5881.353051164283, 5906.291245050449, 5915.40845915405, 5960.493358064613, 5787.334456537552, 5789.942100579109, 5806.390329015392, 5822.76708931655, 5835.708214589338], "value": 5471.577802846446, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4311774461028, 633.5660072850101, 641.8459569703272, 649.1398896462189, 663.3499170812605, 31194.84402577987, 34086.82956585217, 42112.0, 43299.35050974238, 43376.3493547597, 44172.337414938804, 44223.557764422345, 44404.555954440526, 44637.33044004343, 44771.77614111925, 8537.4450660707, 8660.783480412978, 8670.653173873037, 8683.56582170892, 8702.695405660803, 8735.170158834931, 8876.822463550725, 8891.0, 8916.331275154356, 8916.465012099296, 8892.822143557158, 8899.866502002475, 8907.599158037872, 8955.238804701576, 8962.193402593764, 8862.335324850597, 8864.0, 8907.153820387053, 8930.776730581754, 8942.418742781698, 8728.956355218246, 8801.163889430558, 8808.0, 8828.690995815115, 8840.336974726857, 41550.792246038574, 41574.37638435426, 41689.58310416887, 41832.0, 41899.7905010476, 3588.8385022673783, 3608.458731190316, 3652.689521390685, 3751.662350388478, 3772.6793222576116, 32417.51373729396, 32496.675033249838, 32784.50823237653, 34099.31801363959, 34356.0, 4274.123804620045, 4364.54172311909, 4402.493713222956, 4464.955350446487, 4564.771761411949, 332254.0, 332315.0, 333142.0, 333822.0, 334204.328978356, 57856.421435785946, 58109.4189058104, 58300.0, 58511.70744146252, 58560.0, 35973.28053438917, 36617.0, 36685.44971825425, 37915.81042094772, 38518.80740596335, 16176.919115404347, 16201.270942807601, 16243.675126497405, 16262.75605865913, 16264.349426023064, 12780.169288996185, 12914.806277905838, 12937.676558086123, 12992.545260916011, 13015.349232538525, 19881.801181988285, 19893.701594476093, 20042.198312067354, 20053.0, 20072.0, 7304.488685791944, 7374.520656157332, 7412.481126321106, 7440.627968601549, 7642.7325043623205, 959.7600599850037, 1066.6053560182781, 1109.2346281066039, 1115.0, 1150.7065698246893, 33181.5139983419, 33343.66656333454, 33365.66634333674, 33601.0, 33878.32243355119, 1123.3035517978906, 1166.2069792541154, 1169.2763920608743, 1181.474243961429, 1210.1710328425056, 17387.826121738875, 17435.82564174342, 17436.5640858977, 17738.556536086442, 18360.81639183591, 478398.0, 481012.0, 482427.0, 482989.0, 484732.0, 59303.70348148232, 59540.70229648911, 59556.404435955956, 59976.0, 60116.69941650264, 1348.9055766096278, 1353.2692346132978, 1387.6322774464572, 1388.5417812121975, 1406.4374250299961, 32050.519242211853, 34098.65901341054, 34181.31637367189, 34254.65745342515, 34286.852391265864, 51912.740436299086, 52254.0, 52715.47284527259, 52911.0, 52958.0, 427484.0, 429583.0, 430717.0, 431051.0, 432200.0, 27638.170854874385, 28061.158165255074, 28133.296667583476, 28206.29484262828, 28713.28216794597, 49129.75435122802, 49633.0, 50010.0, 50437.24344134767, 50518.49481505138, 41773.95565110897, 42530.14939701251, 42896.0, 42964.14071718611, 43709.12581748283, 41498.1700365997, 42384.364234537126, 42564.55120353988, 42795.35806962836, 42857.57142428661, 36982.63017369792, 41281.1743765117, 41396.0, 41827.58172418237, 42055.57944420516, 35747.0, 38298.42552361773, 38380.950008718406, 38451.0, 38708.80645596754, 28623.284417888888, 28944.42111157723, 29002.56496152517, 29013.0, 29016.419671606873], "value": 20060.680682530376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6700437623644, 389.9239648268589, 392.7466783924368, 394.65029598772196, 405.88838069530874, 13768.793468097962, 18388.90805545972, 19092.5226869328, 20084.69872951907, 20086.397408077744, 18120.81879181208, 18311.08444577769, 18581.628367432644, 18945.242190312372, 19014.0, 5484.478974497416, 5646.858828529279, 5716.1425786131995, 7065.752698655548, 7501.13736920253, 7276.345128938395, 7372.152202496701, 7411.48119631626, 7417.925820741804, 7421.703131874719, 6690.264070952191, 6978.057962175092, 7020.3681668649815, 7102.502824802266, 7121.2878712128895, 6906.482013848957, 7405.074365704287, 7428.9257107428775, 7467.962660186691, 7472.476926615139, 6444.677766111676, 6791.388775010273, 6850.760223392157, 7151.964240178818, 7194.892076618855, 18669.719954200562, 23432.64851027236, 25275.74724252771, 26517.469650607072, 26678.333041674112, 2172.891355432222, 2286.8399212055165, 2341.976580234193, 2400.7996001999, 2437.4515733959893, 15734.370625174979, 15822.841771582367, 15929.28318225671, 16242.75635865463, 16263.18684065792, 2064.700618410322, 2163.8052575268302, 2218.811401030914, 2232.4307301637978, 2233.2853486884205, 88787.0, 88995.55502222512, 89998.0, 92228.53885730596, 94160.0, 16237.51287461378, 17727.645447090985, 17928.193231304624, 17938.013409262618, 18449.5387615308, 31305.530417043763, 31569.0, 31629.051128466184, 31738.619603529827, 31759.364812703618, 9025.23285520725, 9205.907940920504, 9552.761180970532, 9612.75968100803, 9824.65613703517, 7826.686932522635, 7919.604019798987, 7982.560959147303, 8043.638036288381, 8044.879326810103, 8712.433691810013, 8953.462792232487, 8971.147740964598, 9011.684591039282, 9110.453372797654, 3546.7517273790586, 3601.5318008659233, 3606.6753992140834, 3682.3187710273687, 3705.6479634434686, 862.1637012098255, 980.4019548075668, 1031.9329243599143, 1075.983860242097, 1095.895889890459, 19110.2355905765, 19296.0, 20867.269645562636, 20891.724829502422, 20998.790012099988, 973.1144658360857, 1054.6730513540826, 1058.25921854702, 1096.5394534295615, 1144.5650652752067, 10765.89234107649, 11162.441877906072, 11165.83251251232, 11174.66476005721, 11203.71990700239, 440389.0, 441330.0, 441521.0, 444342.0, 451272.0, 85158.0, 85474.0, 85623.0, 88820.0, 88888.5555572218, 1056.0812093478723, 1057.8889216632142, 1071.3197119828965, 1074.1621535202555, 1104.3705088099866, 17227.0, 17283.308667653153, 17449.214785334436, 17476.30094796245, 17485.562860928578, 39414.605853941095, 39990.0, 40172.598274018055, 40655.7967210162, 44244.33633495436, 60282.0, 61230.693846530485, 62193.0, 62413.375866240756, 62496.375036249054, 7619.504732192389, 7735.149133595412, 8295.62669679878, 8307.543085130375, 8609.225169734504, 13061.34693265314, 13489.325533723471, 13634.659133521345, 13666.316684165553, 13674.93162534181, 11336.94331528337, 11466.770664586495, 11769.705757356134, 11836.70408239801, 11877.881221187678, 5450.509454149145, 10614.150867930393, 11409.828852567052, 11470.935231658048, 11613.303201807581, 11643.417829108681, 11865.228760130563, 12091.516339346328, 12159.939200303941, 12627.93686031564, 8482.533460659723, 8818.603162857815, 8821.691240806542, 8912.0, 8945.821083578423, 11762.411879406167, 12055.879441205476, 12067.81898271509, 12227.266364018187, 12310.446029928495], "value": 10383.361519029653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.7780332950053, 1509.7131545006448, 1660.6761681472117, 1788.1148831328494, 1804.521801722543, 7884.369250459964, 8915.465072095663, 9078.773030674236, 9385.483798391086, 9399.389039712414, 8948.32887533436, 9215.769605759859, 9286.953565232181, 9319.673811416586, 9322.720318390458, 2353.1528649686097, 2393.4614711689906, 2394.832361734679, 2395.3652282145244, 2395.377201927494, 2358.740538540759, 2374.3351861478814, 2376.8217383696206, 2385.950181919958, 2386.3795413192606, 2337.1819863047967, 2341.180586794617, 2351.200591798788, 2358.056777289081, 2375.798057165143, 2279.8632082075046, 2300.1144559344607, 2305.804006659436, 2314.2941402872116, 2322.384568089449, 2309.261036468331, 2309.388012176758, 2311.0871205873586, 2336.1823361823394, 2346.343023953296, 9090.363674542785, 9137.771555711093, 9143.994160642324, 9208.815823683488, 9209.769755756093, 5274.2879711238875, 5373.247745315659, 5374.946250537484, 5413.458654134555, 5419.864503387407, 3323.88366407177, 3388.8644454221803, 3389.9322013559836, 3398.2523844754114, 3461.8615255389755, 1069.9625513107003, 1082.242430298794, 1083.7507373304184, 1084.203110713625, 1099.912007039435, 12856.55002074923, 12858.485660573566, 12880.742385152245, 12894.871051289461, 12974.80537791934, 4552.430946131733, 4612.561806628432, 4699.895524551727, 4717.292406139107, 4740.881477963078, 10692.786144277226, 10732.195085368628, 10739.409332486632, 10781.02970732638, 10791.24461287718, 5294.655847369909, 5408.648437851606, 5415.160650099241, 5416.052190866582, 5417.945820541823, 4257.63810076147, 4841.564259216688, 4936.617747030838, 4957.0, 4977.626677999165, 4034.2133284009337, 4059.3505039193587, 4079.63283304504, 4099.61053699898, 4123.326739283028, 1248.581725122076, 1250.637315178588, 1254.6549698832712, 1278.4758249117817, 1282.5959822655834, 1033.679559336593, 1041.1878734587035, 1047.3297089862494, 1063.8882917293727, 1065.2436769893463, 6357.823802596442, 6369.14016607752, 6392.232932048091, 6411.519136064814, 6560.081588577603, 433.8156283579466, 439.38266735237045, 446.09442831053013, 448.6007453366506, 449.1398970970555, 4401.471823381215, 4496.887577810581, 4538.546145385435, 4563.041761230113, 4568.246239370533, 11109.277896936674, 11646.0, 11648.88351116495, 11649.650510484698, 11699.590514331958, 10692.786144277072, 11116.277441966246, 11513.88486115145, 11578.71053223676, 11584.247023943417, 8421.873671894926, 8619.655213791379, 8628.439151455135, 8632.309415246766, 8666.566671666518, 6129.570930034854, 6343.492520598434, 6352.968235158794, 6409.03864420322, 6465.06256592782, 10572.101371383518, 10617.575296988034, 10690.41202733857, 10713.142948564253, 10736.0, 10073.949630252095, 10498.580056797642, 10595.258331916692, 10808.945955270174, 10918.0, 7235.963820180866, 7747.496412733154, 7797.883031754642, 7802.0, 8106.229908158715, 9017.909820901707, 9049.095090490899, 9066.546672666473, 9119.316051296046, 9157.542122893696, 7947.086085100287, 8111.351091912515, 8292.917070829215, 8397.244248017463, 8398.0, 8026.43814932949, 8085.8787118192095, 8188.2630563249595, 8200.671973121247, 8222.465539739898, 7040.718371265092, 7129.500934934505, 7267.0552828132, 7282.67227974753, 7321.158066822383, 5448.4006759257245, 5500.614956952975, 5511.145772405283, 5593.133064375028, 5631.324241091095, 5390.598444404404, 5449.455054494519, 5493.285872836505, 5537.280153580009, 5611.719414029364], "value": 4710.0664938930395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1378168691037, 310.5404002076926, 312.8545226469691, 317.93641271745656, 318.644711147071, 5676.460736230062, 5734.655920644765, 5767.567432442573, 5788.768449262035, 5796.855078623036, 5585.748641311141, 5586.597762961935, 5588.944110558893, 5621.173118736417, 5639.449151483344, 4147.502299724038, 4201.991522034705, 4343.913121737563, 4361.520232774392, 4381.474223093233, 4354.847580334673, 4357.259265924785, 4366.716163449381, 4385.407969924051, 4389.7146685465505, 4363.974466000487, 4370.628496577795, 4379.868603941887, 4394.07724377881, 4396.912061758763, 4299.269124248885, 4345.174416860802, 4354.673399495051, 4368.453943257093, 4379.5182529921685, 3790.2564820182747, 3813.180166264239, 3826.598207188261, 3834.69322454203, 3836.8848934532007, 5438.564914806806, 5442.809501667422, 5462.945370546284, 5474.753636086386, 5513.862153446155, 4845.491223421525, 4918.163912134945, 5014.24786282057, 5015.22264049073, 5035.546800787946, 5787.305523337226, 5808.809194115196, 5857.589968702193, 5893.970530147365, 5909.936211481931, 4173.31140361843, 4201.873943781691, 4210.305299625558, 4221.134667393177, 4223.282042052859, 5903.763849446017, 6218.502519798405, 6273.215848018997, 6283.340249273806, 6290.591111577779, 4118.258713431611, 4134.945588874818, 4144.772037537964, 4149.439825623563, 4163.458750362433, 4193.790310484464, 4212.599803018708, 4226.197022565702, 4231.555686652919, 4231.576842315744, 4797.2564252540915, 4942.629302802305, 4961.479044700327, 4963.553280204726, 4993.051320249214, 5945.316288626776, 5997.550183736237, 6032.969835150796, 6057.182280392179, 6058.333583305833, 1462.6197188730794, 1473.0351619688906, 1474.1523623916291, 1481.7258807120718, 1484.406237504985, 925.2459245714721, 938.6808485115093, 985.0, 986.8421052631688, 995.9053889880449, 5605.523530499953, 5621.578381621394, 5640.0, 5642.153676948491, 5700.629459085229, 6006.279246490449, 6054.606450580786, 6063.0, 6104.664243466652, 6138.508919286446, 5448.400675925645, 5573.024720673866, 5656.5757568181725, 5659.943400565941, 5697.487226149667, 3265.48155107876, 3271.3130242648836, 3274.983625081907, 3277.852496637657, 3288.638249792521, 5973.104034394875, 6163.890499710005, 6200.3179650238435, 6201.782937597162, 6276.7090012146155, 6146.7233974471255, 6157.168782214433, 6162.445379915829, 6170.382961703794, 6177.660228687465, 5869.207656966255, 6130.846728831815, 6170.784022559189, 6197.318294987548, 6267.4045965633195, 5925.970370148294, 5994.250718660168, 6014.879702406015, 6049.667268300285, 6065.302490213682, 5979.671118088547, 5982.521398288213, 5984.670843103671, 5987.371326010706, 5991.502124468882, 5986.610870293591, 6157.907631385443, 6192.752289908533, 6211.503079753518, 6238.781642642486, 4162.229987452331, 4162.7502349859105, 4188.9162216754885, 4198.958010419857, 4201.747895126302, 5778.335491418373, 5984.760609575568, 6031.306399763907, 6040.2751669798145, 6043.395660433922, 5895.616784908967, 5959.22530071088, 5961.850953726192, 5978.97010514962, 6016.849578760566, 5663.1788390682295, 5866.530677545701, 5888.558358123072, 5902.1441890926435, 5981.0, 5675.829725108253, 5792.94207057924, 5795.710214489343, 5837.766489340379, 5851.64890106595, 5855.238818953509, 5920.674362910081, 5934.347221805684, 5940.613860099253, 5947.851303717269, 5615.6630602164005, 5697.718013446941, 5777.191193232867, 5783.479486846204, 5833.0], "value": 4459.322489472463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.2215140556635, 763.6372722956596, 777.0869228656328, 791.1218547412371, 827.797189688526, 15514.767278490832, 16986.66026679467, 17546.561335966606, 17643.47069587911, 18263.908680456614, 16699.0, 16729.0, 16730.330786768543, 16778.328866845342, 16804.663906721857, 672.8082496488502, 791.4815795653856, 793.6269953122023, 795.8487887301394, 795.8686816675256, 806.9435139540235, 823.6005537314397, 825.8926339575846, 836.1429534726923, 837.6523742646825, 841.0496139362542, 843.3169133002257, 852.7825404521839, 853.2491407561369, 853.5902766672001, 845.1379592815356, 852.2372476633378, 854.2781349759443, 854.5727136431784, 855.8801767752519, 612.7303986246083, 618.709206672863, 620.872721092175, 621.0870021069021, 622.0606883605743, 15403.07581545111, 15441.691166176726, 15448.922755386264, 15449.613759656098, 15458.227088645523, 14572.854271457256, 14767.630809229855, 14877.47928822486, 14933.328000240015, 14975.625609359744, 12448.9248113573, 12581.496740130384, 12632.49470021198, 12727.809082863765, 13346.0, 3778.4521244419407, 3791.6777073948747, 3819.0, 3836.673882719972, 3954.8615798446917, 72180.27819721788, 72433.63783181104, 72671.63664181698, 73175.0, 73184.63407682981, 10728.463576821128, 11031.393273369882, 11126.499307531181, 11280.943595281971, 11560.421978901022, 20355.592888142153, 20539.28112516055, 20568.691469627967, 20674.069666865027, 20702.171913123308, 8684.306560220697, 8796.736097917073, 8807.07525709804, 8827.426217295855, 8875.600597973107, 4707.952920470751, 4709.976450117796, 4909.337239472697, 4918.581920536794, 4928.433230178575, 3658.817059147032, 3889.0471834400755, 3908.726389152732, 3919.9608003920166, 3921.6666583340734, 638.419038674813, 639.4085470939362, 655.1450357283695, 663.4824836627438, 665.0489799586541, 468.8968426946066, 684.1277371351566, 735.4631119282953, 756.8713318735718, 785.4658831994185, 10287.382757034453, 10416.166706663449, 10489.580416783396, 10552.736181595368, 10902.182336324808, 610.7434877351523, 688.8002479281053, 718.8202949262684, 789.8933643958107, 799.9960000199961, 4930.517312376933, 5166.741662916839, 5167.431582525919, 5183.437243846067, 5218.478152184751, 67379.0, 69384.95922561166, 70250.64874675593, 88475.0, 113939.0, 43403.131937361075, 43957.78021109938, 83731.58134209411, 94418.0, 99949.00101998064, 75752.24247757452, 76992.99999999888, 89387.55306223557, 90060.0, 90792.0, 9716.805663886542, 9760.658376956773, 9777.608895644094, 9886.901130988597, 9950.0, 46368.536314636425, 51128.0, 51559.0, 51601.48398515967, 53278.20082698685, 67068.32931670621, 73977.0, 75510.24489755032, 75970.24029759632, 76295.61852190703, 13101.67245818824, 13101.934490327487, 13221.735565288447, 13322.134061285986, 13499.325033748077, 14756.696782374353, 14779.334929927963, 14855.257237137883, 15016.249187540798, 15314.463993760164, 13338.3330833456, 13747.518836840663, 13818.792718109034, 14109.717805643624, 14808.0, 13600.0, 13693.726125477235, 13882.0, 14189.07770994882, 14750.188739618994, 12820.935895320463, 13235.27206003679, 13661.726765464833, 13945.233012184022, 13975.860241397455, 10686.25196236256, 11053.447327633747, 11465.31208127515, 11615.76768464609, 11618.825717614412, 10919.727006824574, 11234.3259404436, 11292.717682058013, 11344.376059316817, 11507.712307192387], "value": 7564.009676876619, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 153.0, 180.0, 127.0, 151.0, 157.0, 127.0, 180.0, 125.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 163.0, 175.0, 164.0, 162.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 167.0, 75.0, 76.0, 74.0, 76.0, 180.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 137.0, 85.0, 85.0, 84.0, 137.0, 84.0, 84.0, 145.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 56.0, 59.0, 55.0, 55.0, 55.0, 58.0, 55.0, 58.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 79.0, 80.0, 83.0, 81.0, 79.0, 81.0, 110.0, 79.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 122.0, 131.0, 128.0, 123.0, 133.0, 133.0, 136.0, 120.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 163.0, 159.0, 158.0, 163.0, 164.0, 158.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 74.0, 66.0, 69.0, 62.0, 65.0, 62.0, 62.0, 65.0, 62.0], "value": 64.9, "unit": "score"}]}]} 04:33:00 INFO - Return code: 0 04:33:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:00 ERROR - # TBPL SUCCESS # 04:33:00 INFO - Running post-action listener: _resource_record_post_action 04:33:00 INFO - ##### 04:33:00 INFO - ##### Finished run-tests step (success) 04:33:00 INFO - ##### 04:33:00 INFO - Running post-run listener: _resource_record_post_run 04:33:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 554549248; Read time: 0; Write time: 624140 04:33:01 INFO - TinderboxPrint: CPU usage
13.5% 04:33:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:01 INFO - TinderboxPrint: I/O write bytes / time
554,549,248 / 624,140 04:33:01 INFO - TinderboxPrint: CPU idle
8,221.4 (86.5%) 04:33:01 INFO - TinderboxPrint: CPU user
1,224.5 (12.9%) 04:33:01 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 261623808; Read time: 0; Write time: 389320 04:33:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292925440; Read time: 0; Write time: 234820 04:33:01 INFO - Running post-run listener: _upload_blobber_files 04:33:01 INFO - Blob upload gear active. 04:33:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:01 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:01 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:02 INFO - (blobuploader) - INFO - Done attempting. 04:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:08 INFO - (blobuploader) - INFO - Done attempting. 04:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:09 INFO - (blobuploader) - INFO - Done attempting. 04:33:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:09 INFO - Return code: 0 04:33:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/016babc7a79913fa7b4ede3fbf078acc7f2c4d1df75e162d75eeef8f1d0e35dbde565af99d49eb4a865211265bd12e82f6d657ee5b8924c3c975ba7565433a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133a40b47ce60be68eacc1c618faedeed2454becc229f7e06b4a272a940c4455c4f3f6dbfa435b73bbe03d6d3741d168b11771a8d801e1fc39cb1e1b2d182b3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedc2c288c04949a9d4ddc0389a2d395fcecb4db06272ea057b78aaf312bdb247079e6c3964f3c82e5b845827fb2889d6dcc30812ee577bfef15a67c34223b8a"} 04:33:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:09 INFO - Contents: 04:33:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/016babc7a79913fa7b4ede3fbf078acc7f2c4d1df75e162d75eeef8f1d0e35dbde565af99d49eb4a865211265bd12e82f6d657ee5b8924c3c975ba7565433a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133a40b47ce60be68eacc1c618faedeed2454becc229f7e06b4a272a940c4455c4f3f6dbfa435b73bbe03d6d3741d168b11771a8d801e1fc39cb1e1b2d182b3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedc2c288c04949a9d4ddc0389a2d395fcecb4db06272ea057b78aaf312bdb247079e6c3964f3c82e5b845827fb2889d6dcc30812ee577bfef15a67c34223b8a"} 04:33:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:09 INFO - Copying logs to upload dir... 04:33:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.038306 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 04:33:08.760724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:08.763831) ========= 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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 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/Firefox/sha512/016babc7a79913fa7b4ede3fbf078acc7f2c4d1df75e162d75eeef8f1d0e35dbde565af99d49eb4a865211265bd12e82f6d657ee5b8924c3c975ba7565433a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133a40b47ce60be68eacc1c618faedeed2454becc229f7e06b4a272a940c4455c4f3f6dbfa435b73bbe03d6d3741d168b11771a8d801e1fc39cb1e1b2d182b3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedc2c288c04949a9d4ddc0389a2d395fcecb4db06272ea057b78aaf312bdb247079e6c3964f3c82e5b845827fb2889d6dcc30812ee577bfef15a67c34223b8a"} build_url:https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/YHdGyUxeQdCa1aVHz9KeXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/016babc7a79913fa7b4ede3fbf078acc7f2c4d1df75e162d75eeef8f1d0e35dbde565af99d49eb4a865211265bd12e82f6d657ee5b8924c3c975ba7565433a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133a40b47ce60be68eacc1c618faedeed2454becc229f7e06b4a272a940c4455c4f3f6dbfa435b73bbe03d6d3741d168b11771a8d801e1fc39cb1e1b2d182b3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedc2c288c04949a9d4ddc0389a2d395fcecb4db06272ea057b78aaf312bdb247079e6c3964f3c82e5b845827fb2889d6dcc30812ee577bfef15a67c34223b8a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:08.791486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:08.791777) ========= 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=db0483c52d987ecb441a263b000001ad-1465031935.708729-870335097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 04:33:08.877165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 04:33:08.877485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 04:33:08.877757) ========= ========= Total master_lag: 0.19 =========