builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1467526734.59 results: success (0) buildid: 20160702004021 builduid: cba7f276d3d54b85ad6d3821d90a3962 revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.594374) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.595400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.596090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.614755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.615564) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:18:55-- 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% 26.7M=0s 2016-07-02 23:18:55 (26.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.782902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.783265) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017797 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:54.836057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:18:54.836914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:18:56,095 truncating revision to first 12 chars 2016-07-02 23:18:56,095 Setting DEBUG logging. 2016-07-02 23:18:56,095 attempt 1/10 2016-07-02 23:18:56,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b59259518acd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:18:56,823 unpacking tar archive at: mozilla-aurora-b59259518acd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.103119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:18:55.960211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:55.961031) ========= script_repo_revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:55.962023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:55.962949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:18:55.975613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-02 23:18:55.976350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:18:57 INFO - MultiFileLogger online at 20160702 23:18:57 in /builds/slave/test 23:18:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:18:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:18:57 INFO - {'append_to_log': False, 23:18:57 INFO - 'base_work_dir': '/builds/slave/test', 23:18:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:18:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:18:57 INFO - 'branch': 'Mozilla-Aurora', 23:18:57 INFO - 'buildbot_json_path': 'buildprops.json', 23:18:57 INFO - 'config_files': ('talos/linux_config.py',), 23:18:57 INFO - 'default_actions': ('clobber', 23:18:57 INFO - 'read-buildbot-config', 23:18:57 INFO - 'download-and-extract', 23:18:57 INFO - 'populate-webroot', 23:18:57 INFO - 'create-virtualenv', 23:18:57 INFO - 'install', 23:18:57 INFO - 'run-tests'), 23:18:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:18:57 INFO - 'download_minidump_stackwalk': True, 23:18:57 INFO - 'download_symbols': 'ondemand', 23:18:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:18:57 INFO - 'tooltool.py': '/tools/tooltool.py', 23:18:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:18:57 INFO - '/tools/misc-python/virtualenv.py')}, 23:18:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:18:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:18:57 INFO - 'installer_path': 'installer.exe', 23:18:57 INFO - 'log_level': 'info', 23:18:57 INFO - 'log_name': 'talos', 23:18:57 INFO - 'log_to_console': True, 23:18:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:18:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:18:57 INFO - 'opt_config_files': (), 23:18:57 INFO - 'pip_index': False, 23:18:57 INFO - 'sps_profile': False, 23:18:57 INFO - 'sps_profile_interval': 0, 23:18:57 INFO - 'suite': 'dromaeojs-e10s', 23:18:57 INFO - 'system_bits': '32', 23:18:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:18:57 INFO - 'title': 'talos-linux64-ix-004', 23:18:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:18:57 INFO - 'use_talos_json': True, 23:18:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:18:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:18:57 INFO - 'work_dir': 'build'} 23:18:57 INFO - ##### 23:18:57 INFO - ##### Running clobber step. 23:18:57 INFO - ##### 23:18:57 INFO - Running pre-action listener: _resource_record_pre_action 23:18:57 INFO - Running main action method: clobber 23:18:57 INFO - rmtree: /builds/slave/test/build 23:18:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:18:57 INFO - Running post-action listener: _resource_record_post_action 23:18:57 INFO - ##### 23:18:57 INFO - ##### Finished clobber step (success) 23:18:57 INFO - ##### 23:18:57 INFO - ##### 23:18:57 INFO - ##### Running read-buildbot-config step. 23:18:57 INFO - ##### 23:18:57 INFO - Running pre-action listener: _resource_record_pre_action 23:18:57 INFO - Running main action method: read_buildbot_config 23:18:57 INFO - Using buildbot properties: 23:18:57 INFO - { 23:18:57 INFO - "project": "", 23:18:57 INFO - "product": "firefox", 23:18:57 INFO - "script_repo_revision": "production", 23:18:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:18:57 INFO - "repository": "", 23:18:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:18:57 INFO - "buildid": "20160702004021", 23:18:57 INFO - "stage_platform": "linux64-pgo", 23:18:57 INFO - "basedir": "/builds/slave/test", 23:18:57 INFO - "nightly_build": "True", 23:18:57 INFO - "buildnumber": 379, 23:18:57 INFO - "slavename": "talos-linux64-ix-004", 23:18:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:18:57 INFO - "platform": "ubuntu64_hw", 23:18:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:18:57 INFO - "branch": "mozilla-aurora", 23:18:57 INFO - "repo_path": "releases/mozilla-aurora", 23:18:57 INFO - "revision": "b59259518acd507a14c72a0f106f70158ef8d7c6", 23:18:57 INFO - "pgo_build": "True", 23:18:57 INFO - "builduid": "cba7f276d3d54b85ad6d3821d90a3962", 23:18:57 INFO - "slavebuilddir": "test" 23:18:57 INFO - } 23:18:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:18:57 INFO - Running post-action listener: _resource_record_post_action 23:18:57 INFO - ##### 23:18:57 INFO - ##### Finished read-buildbot-config step (success) 23:18:57 INFO - ##### 23:18:57 INFO - ##### 23:18:57 INFO - ##### Running download-and-extract step. 23:18:57 INFO - ##### 23:18:57 INFO - Running pre-action listener: _resource_record_pre_action 23:18:57 INFO - Running main action method: download_and_extract 23:18:57 INFO - mkdir: /builds/slave/test/build/tests 23:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:57 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:18:58 INFO - Downloaded 1361 bytes. 23:18:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:18:58 INFO - Using the following test package requirements: 23:18:58 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:18:58 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:18:58 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:18:58 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'jsshell-linux-x86_64.zip'], 23:18:58 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:18:58 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:18:58 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:18:58 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:18:58 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:18:58 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:18:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:18:58 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:58 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:18:59 INFO - Downloaded 24526247 bytes. 23:18:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:18:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:19:00 INFO - Return code: 0 23:19:00 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:19:00 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')]} 23:19:00 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:19:01 INFO - Downloaded 24526247 bytes. 23:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:19:03 INFO - Return code: 0 23:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:03 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:19:04 INFO - Downloaded 10833369 bytes. 23:19:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:19:04 INFO - Return code: 0 23:19:04 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')]} 23:19:04 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:19:06 INFO - Downloaded 63606784 bytes. 23:19:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:19:06 INFO - mkdir: /builds/slave/test/properties 23:19:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:19:06 INFO - Writing to file /builds/slave/test/properties/build_url 23:19:06 INFO - Contents: 23:19:06 INFO - build_url:https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:19:06 INFO - Running post-action listener: _resource_record_post_action 23:19:06 INFO - Running post-action listener: set_extra_try_arguments 23:19:06 INFO - ##### 23:19:06 INFO - ##### Finished download-and-extract step (success) 23:19:06 INFO - ##### 23:19:06 INFO - ##### 23:19:06 INFO - ##### Running populate-webroot step. 23:19:06 INFO - ##### 23:19:06 INFO - Running pre-action listener: _resource_record_pre_action 23:19:06 INFO - Running main action method: populate_webroot 23:19:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:19:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:19:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:19:06 INFO - '--tppagecycles', 23:19:06 INFO - '7'], 23:19:06 INFO - 'tests': ['tsvgm']}}, 23:19:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:19:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:19:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:19:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:19:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['damp', 'tps']}, 23:19:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'tests': ['damp', 'tps']}, 23:19:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['dromaeo_dom']}, 23:19:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:19:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'other-e10s': {'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['a11yr', 23:19:06 INFO - 'ts_paint', 23:19:06 INFO - 'tpaint', 23:19:06 INFO - 'sessionrestore', 23:19:06 INFO - 'sessionrestore_no_auto_restore', 23:19:06 INFO - 'tabpaint']}, 23:19:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['tsvgx', 23:19:06 INFO - 'tsvgr_opacity', 23:19:06 INFO - 'tart', 23:19:06 INFO - 'tscrollx', 23:19:06 INFO - 'cart']}, 23:19:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:19:06 INFO - 'tsvgr_opacity', 23:19:06 INFO - 'tart', 23:19:06 INFO - 'tscrollx', 23:19:06 INFO - 'cart']}, 23:19:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'talos_options': ['--disable-e10s'], 23:19:06 INFO - 'tests': ['tp5o']}, 23:19:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'tests': ['tp5o']}, 23:19:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'talos_options': ['--disable-e10s', 23:19:06 INFO - '--xperf_path', 23:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:06 INFO - 'tests': ['tp5n']}, 23:19:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:06 INFO - 'talos_options': ['--xperf_path', 23:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:06 INFO - 'tests': ['tp5n']}}, 23:19:06 INFO - 'talos.zip': {'path': '', 23:19:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:19:06 INFO - Running post-action listener: _resource_record_post_action 23:19:06 INFO - ##### 23:19:06 INFO - ##### Finished populate-webroot step (success) 23:19:06 INFO - ##### 23:19:06 INFO - ##### 23:19:06 INFO - ##### Running create-virtualenv step. 23:19:06 INFO - ##### 23:19:06 INFO - Running pre-action listener: _resource_record_pre_action 23:19:06 INFO - Running main action method: create_virtualenv 23:19:06 INFO - Creating virtualenv /builds/slave/test/build/venv 23:19:06 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 23:19:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:19:06 INFO - Using real prefix '/usr' 23:19:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 23:19:09 INFO - Installing pip.................done. 23:19:09 INFO - Return code: 0 23:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:19:09 INFO - Using env: {'DISPLAY': ':0', 23:19:09 INFO - 'HOME': '/home/cltbld', 23:19:09 INFO - 'LANG': 'en_US.UTF-8', 23:19:09 INFO - 'LANGUAGE': 'en_US:en', 23:19:09 INFO - 'LOGNAME': 'cltbld', 23:19:09 INFO - 'MAIL': '/var/mail/cltbld', 23:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:09 INFO - 'MOZ_NO_REMOTE': '1', 23:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:09 INFO - 'NO_EM_RESTART': '1', 23:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:09 INFO - 'PWD': '/builds/slave/test', 23:19:09 INFO - 'SHELL': '/bin/bash', 23:19:09 INFO - 'SHLVL': '1', 23:19:09 INFO - 'TERM': 'linux', 23:19:09 INFO - 'TMOUT': '86400', 23:19:09 INFO - 'USER': 'cltbld', 23:19:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:09 INFO - '_': '/tools/buildbot/bin/python'} 23:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:09 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 23:19:09 INFO - Cleaning up... 23:19:09 INFO - Return code: 0 23:19:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:19:09 INFO - Using env: {'DISPLAY': ':0', 23:19:09 INFO - 'HOME': '/home/cltbld', 23:19:09 INFO - 'LANG': 'en_US.UTF-8', 23:19:09 INFO - 'LANGUAGE': 'en_US:en', 23:19:09 INFO - 'LOGNAME': 'cltbld', 23:19:09 INFO - 'MAIL': '/var/mail/cltbld', 23:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:09 INFO - 'MOZ_NO_REMOTE': '1', 23:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:09 INFO - 'NO_EM_RESTART': '1', 23:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:09 INFO - 'PWD': '/builds/slave/test', 23:19:09 INFO - 'SHELL': '/bin/bash', 23:19:09 INFO - 'SHLVL': '1', 23:19:09 INFO - 'TERM': 'linux', 23:19:09 INFO - 'TMOUT': '86400', 23:19:09 INFO - 'USER': 'cltbld', 23:19:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:09 INFO - '_': '/tools/buildbot/bin/python'} 23:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:09 INFO - Downloading/unpacking psutil>=3.1.1 23:19: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 23:19: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 23:19: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 23:19: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 23:19: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 23:19: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 23:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:11 INFO - Installing collected packages: psutil 23:19:11 INFO - Running setup.py install for psutil 23:19:11 INFO - building 'psutil._psutil_linux' extension 23:19:11 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 23:19:12 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 23:19:12 INFO - building 'psutil._psutil_posix' extension 23:19:12 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 23:19:12 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 23:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:12 INFO - Successfully installed psutil 23:19:12 INFO - Cleaning up... 23:19:12 INFO - Return code: 0 23:19:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:12 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:12 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 23:19:12 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 23:19:12 INFO - Using env: {'DISPLAY': ':0', 23:19:12 INFO - 'HOME': '/home/cltbld', 23:19:12 INFO - 'LANG': 'en_US.UTF-8', 23:19:12 INFO - 'LANGUAGE': 'en_US:en', 23:19:12 INFO - 'LOGNAME': 'cltbld', 23:19:12 INFO - 'MAIL': '/var/mail/cltbld', 23:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:12 INFO - 'MOZ_NO_REMOTE': '1', 23:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:12 INFO - 'NO_EM_RESTART': '1', 23:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:12 INFO - 'PWD': '/builds/slave/test', 23:19:12 INFO - 'SHELL': '/bin/bash', 23:19:12 INFO - 'SHLVL': '1', 23:19:12 INFO - 'TERM': 'linux', 23:19:12 INFO - 'TMOUT': '86400', 23:19:12 INFO - 'USER': 'cltbld', 23:19:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:12 INFO - '_': '/tools/buildbot/bin/python'} 23:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:19:14 INFO - Installing collected packages: mozsystemmonitor 23:19:14 INFO - Running setup.py install for mozsystemmonitor 23:19:14 INFO - Successfully installed mozsystemmonitor 23:19:14 INFO - Cleaning up... 23:19:14 INFO - Return code: 0 23:19:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:19:14 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')]} 23:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:14 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')]} 23:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:14 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:14 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 23:19:14 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 23:19:14 INFO - Using env: {'DISPLAY': ':0', 23:19:14 INFO - 'HOME': '/home/cltbld', 23:19:14 INFO - 'LANG': 'en_US.UTF-8', 23:19:14 INFO - 'LANGUAGE': 'en_US:en', 23:19:14 INFO - 'LOGNAME': 'cltbld', 23:19:14 INFO - 'MAIL': '/var/mail/cltbld', 23:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:14 INFO - 'MOZ_NO_REMOTE': '1', 23:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:14 INFO - 'NO_EM_RESTART': '1', 23:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:14 INFO - 'PWD': '/builds/slave/test', 23:19:14 INFO - 'SHELL': '/bin/bash', 23:19:14 INFO - 'SHLVL': '1', 23:19:14 INFO - 'TERM': 'linux', 23:19:14 INFO - 'TMOUT': '86400', 23:19:14 INFO - 'USER': 'cltbld', 23:19:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:14 INFO - '_': '/tools/buildbot/bin/python'} 23:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:14 INFO - Downloading/unpacking jsonschema==2.5.1 23:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:19:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:19:16 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 23:19:16 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 23:19:16 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 23:19:16 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 23:19:16 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 23:19:16 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 23:19:16 INFO - Downloading functools32-3.2.3-2.tar.gz 23:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:19:17 INFO - warning: no files found matching '*.txt' 23:19:17 INFO - no previously-included directories found matching 'build' 23:19:17 INFO - no previously-included directories found matching 'dist' 23:19:17 INFO - no previously-included directories found matching '.git*' 23:19:17 INFO - Installing collected packages: jsonschema, functools32 23:19:17 INFO - Running setup.py install for functools32 23:19:17 INFO - warning: no files found matching '*.txt' 23:19:17 INFO - no previously-included directories found matching 'build' 23:19:17 INFO - no previously-included directories found matching 'dist' 23:19:17 INFO - no previously-included directories found matching '.git*' 23:19:17 INFO - Successfully installed jsonschema functools32 23:19:17 INFO - Cleaning up... 23:19:17 INFO - Return code: 0 23:19:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:19:17 INFO - Using env: {'DISPLAY': ':0', 23:19:17 INFO - 'HOME': '/home/cltbld', 23:19:17 INFO - 'LANG': 'en_US.UTF-8', 23:19:17 INFO - 'LANGUAGE': 'en_US:en', 23:19:17 INFO - 'LOGNAME': 'cltbld', 23:19:17 INFO - 'MAIL': '/var/mail/cltbld', 23:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:17 INFO - 'MOZ_NO_REMOTE': '1', 23:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:17 INFO - 'NO_EM_RESTART': '1', 23:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:17 INFO - 'PWD': '/builds/slave/test', 23:19:17 INFO - 'SHELL': '/bin/bash', 23:19:17 INFO - 'SHLVL': '1', 23:19:17 INFO - 'TERM': 'linux', 23:19:17 INFO - 'TMOUT': '86400', 23:19:17 INFO - 'USER': 'cltbld', 23:19:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:17 INFO - '_': '/tools/buildbot/bin/python'} 23:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:17 INFO - Downloading/unpacking blobuploader==1.2.4 23:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:19 INFO - Downloading blobuploader-1.2.4.tar.gz 23:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:19:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:19:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:20 INFO - Downloading docopt-0.6.1.tar.gz 23:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:19:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:19:20 INFO - Running setup.py install for blobuploader 23:19:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:19:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:19:20 INFO - Running setup.py install for requests 23:19:20 INFO - Running setup.py install for docopt 23:19:20 INFO - Successfully installed blobuploader requests docopt 23:19:20 INFO - Cleaning up... 23:19:20 INFO - Return code: 0 23:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:20 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')]} 23:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:20 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')]} 23:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:20 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:20 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 23:19:20 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 23:19:20 INFO - Using env: {'DISPLAY': ':0', 23:19:20 INFO - 'HOME': '/home/cltbld', 23:19:20 INFO - 'LANG': 'en_US.UTF-8', 23:19:20 INFO - 'LANGUAGE': 'en_US:en', 23:19:20 INFO - 'LOGNAME': 'cltbld', 23:19:20 INFO - 'MAIL': '/var/mail/cltbld', 23:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:20 INFO - 'MOZ_NO_REMOTE': '1', 23:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:20 INFO - 'NO_EM_RESTART': '1', 23:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:20 INFO - 'PWD': '/builds/slave/test', 23:19:20 INFO - 'SHELL': '/bin/bash', 23:19:20 INFO - 'SHLVL': '1', 23:19:20 INFO - 'TERM': 'linux', 23:19:20 INFO - 'TMOUT': '86400', 23:19:20 INFO - 'USER': 'cltbld', 23:19:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:20 INFO - '_': '/tools/buildbot/bin/python'} 23:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:19:20 INFO - Running setup.py (path:/tmp/pip-Jg9SuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:19:20 INFO - Running setup.py (path:/tmp/pip-PPMF9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:19:21 INFO - Running setup.py (path:/tmp/pip-jHulsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:19:21 INFO - Running setup.py (path:/tmp/pip-MIL2CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:19:21 INFO - Running setup.py (path:/tmp/pip-xXjx6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:19:21 INFO - Running setup.py (path:/tmp/pip-bcx9DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:19:21 INFO - Running setup.py (path:/tmp/pip-cE9sA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:19:21 INFO - Running setup.py (path:/tmp/pip-S7hRh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:19:21 INFO - Running setup.py (path:/tmp/pip-AqWH6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:19:21 INFO - Running setup.py (path:/tmp/pip-gPVKM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:19:21 INFO - Running setup.py (path:/tmp/pip-FCuqvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:19:21 INFO - Running setup.py (path:/tmp/pip-B4pQZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:19:21 INFO - Running setup.py (path:/tmp/pip-y15DB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:19:21 INFO - Running setup.py (path:/tmp/pip-qirS5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:21 INFO - Running setup.py (path:/tmp/pip-_DVKpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:19:22 INFO - Running setup.py (path:/tmp/pip-aJklSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:19:22 INFO - Running setup.py (path:/tmp/pip-OpgxlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:19:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:19:22 INFO - Running setup.py install for manifestparser 23:19:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Running setup.py install for mozcrash 23:19:22 INFO - Running setup.py install for mozdebug 23:19:22 INFO - Running setup.py install for mozdevice 23:19:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Running setup.py install for mozfile 23:19:22 INFO - Running setup.py install for mozhttpd 23:19:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Running setup.py install for mozinfo 23:19:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Running setup.py install for mozInstall 23:19:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:19:22 INFO - Running setup.py install for mozleak 23:19:23 INFO - Running setup.py install for mozlog 23:19:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Running setup.py install for moznetwork 23:19:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Running setup.py install for mozprocess 23:19:23 INFO - Running setup.py install for mozprofile 23:19:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Running setup.py install for mozrunner 23:19:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Running setup.py install for mozscreenshot 23:19:23 INFO - Running setup.py install for moztest 23:19:23 INFO - Running setup.py install for mozversion 23:19:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:19:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:19:23 INFO - Cleaning up... 23:19:23 INFO - Return code: 0 23:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:23 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:23 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 23:19:23 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 23:19:23 INFO - Using env: {'DISPLAY': ':0', 23:19:23 INFO - 'HOME': '/home/cltbld', 23:19:23 INFO - 'LANG': 'en_US.UTF-8', 23:19:23 INFO - 'LANGUAGE': 'en_US:en', 23:19:23 INFO - 'LOGNAME': 'cltbld', 23:19:23 INFO - 'MAIL': '/var/mail/cltbld', 23:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:23 INFO - 'MOZ_NO_REMOTE': '1', 23:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:23 INFO - 'NO_EM_RESTART': '1', 23:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:23 INFO - 'PWD': '/builds/slave/test', 23:19:23 INFO - 'SHELL': '/bin/bash', 23:19:23 INFO - 'SHLVL': '1', 23:19:23 INFO - 'TERM': 'linux', 23:19:23 INFO - 'TMOUT': '86400', 23:19:23 INFO - 'USER': 'cltbld', 23:19:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:23 INFO - '_': '/tools/buildbot/bin/python'} 23:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:19:24 INFO - Running setup.py (path:/tmp/pip-sjI7Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:19:24 INFO - Running setup.py (path:/tmp/pip-ybGxIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:19:24 INFO - Running setup.py (path:/tmp/pip-qCoarO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:19:24 INFO - Running setup.py (path:/tmp/pip-N3MN8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:19:24 INFO - Running setup.py (path:/tmp/pip-SaeqSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:19:24 INFO - Running setup.py (path:/tmp/pip-Xpc6xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:19:24 INFO - Running setup.py (path:/tmp/pip-ILDwnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:19:24 INFO - Running setup.py (path:/tmp/pip-L2VOG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:19:24 INFO - Running setup.py (path:/tmp/pip-v4fKuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:19:24 INFO - Running setup.py (path:/tmp/pip-netbOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:19:24 INFO - Running setup.py (path:/tmp/pip-hLJKCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:19:24 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)) 23:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:19:24 INFO - Running setup.py (path:/tmp/pip-GzYv2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:19:25 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)) 23:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:19:25 INFO - Running setup.py (path:/tmp/pip-IoUlOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:19:25 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)) 23:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:19:25 INFO - Running setup.py (path:/tmp/pip-sCOnXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:19:25 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)) 23:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:25 INFO - Running setup.py (path:/tmp/pip-FA5E2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:25 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)) 23:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:19:25 INFO - Running setup.py (path:/tmp/pip-GmLnjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:19:25 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)) 23:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:19:25 INFO - Running setup.py (path:/tmp/pip-8wrGxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:19:25 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)) 23:19:25 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)) 23:19:25 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)) 23:19:25 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)) 23:19:25 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)) 23:19:25 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)) 23:19:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:19:25 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 23:19:25 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 23:19:25 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 23:19:25 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 23:19:25 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 23:19:25 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 23:19:27 INFO - Downloading blessings-1.6.tar.gz 23:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:19:27 INFO - Installing collected packages: blessings 23:19:27 INFO - Running setup.py install for blessings 23:19:27 INFO - Successfully installed blessings 23:19:27 INFO - Cleaning up... 23:19:27 INFO - Return code: 0 23:19:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:27 INFO - Reading from file tmpfile_stdout 23:19:27 INFO - Current package versions: 23:19:27 INFO - argparse == 1.2.1 23:19:27 INFO - blessings == 1.6 23:19:27 INFO - blobuploader == 1.2.4 23:19:27 INFO - docopt == 0.6.1 23:19:27 INFO - functools32 == 3.2.3-2 23:19:27 INFO - jsonschema == 2.5.1 23:19:27 INFO - manifestparser == 1.1 23:19:27 INFO - mozInstall == 1.12 23:19:27 INFO - mozcrash == 0.17 23:19:27 INFO - mozdebug == 0.1 23:19:27 INFO - mozdevice == 0.48 23:19:27 INFO - mozfile == 1.2 23:19:27 INFO - mozhttpd == 0.7 23:19:27 INFO - mozinfo == 0.9 23:19:27 INFO - mozleak == 0.1 23:19:27 INFO - mozlog == 3.2 23:19:27 INFO - moznetwork == 0.27 23:19:27 INFO - mozprocess == 0.22 23:19:27 INFO - mozprofile == 0.28 23:19:27 INFO - mozrunner == 6.11 23:19:27 INFO - mozscreenshot == 0.1 23:19:27 INFO - mozsystemmonitor == 0.3 23:19:27 INFO - moztest == 0.7 23:19:27 INFO - mozversion == 1.4 23:19:27 INFO - psutil == 3.1.1 23:19:27 INFO - requests == 1.2.3 23:19:27 INFO - wsgiref == 0.1.2 23:19:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:27 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:27 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 23:19:27 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 23:19:27 INFO - Using env: {'DISPLAY': ':0', 23:19:27 INFO - 'HOME': '/home/cltbld', 23:19:27 INFO - 'LANG': 'en_US.UTF-8', 23:19:27 INFO - 'LANGUAGE': 'en_US:en', 23:19:27 INFO - 'LOGNAME': 'cltbld', 23:19:27 INFO - 'MAIL': '/var/mail/cltbld', 23:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:27 INFO - 'MOZ_NO_REMOTE': '1', 23:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:27 INFO - 'NO_EM_RESTART': '1', 23:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:27 INFO - 'PWD': '/builds/slave/test', 23:19:27 INFO - 'SHELL': '/bin/bash', 23:19:27 INFO - 'SHLVL': '1', 23:19:27 INFO - 'TERM': 'linux', 23:19:27 INFO - 'TMOUT': '86400', 23:19:27 INFO - 'USER': 'cltbld', 23:19:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:27 INFO - '_': '/tools/buildbot/bin/python'} 23:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 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)) 23:19:27 INFO - Cleaning up... 23:19:27 INFO - Return code: 0 23:19:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:19:27 INFO - Using env: {'DISPLAY': ':0', 23:19:27 INFO - 'HOME': '/home/cltbld', 23:19:27 INFO - 'LANG': 'en_US.UTF-8', 23:19:27 INFO - 'LANGUAGE': 'en_US:en', 23:19:27 INFO - 'LOGNAME': 'cltbld', 23:19:27 INFO - 'MAIL': '/var/mail/cltbld', 23:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:27 INFO - 'MOZ_NO_REMOTE': '1', 23:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:27 INFO - 'NO_EM_RESTART': '1', 23:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:27 INFO - 'PWD': '/builds/slave/test', 23:19:27 INFO - 'SHELL': '/bin/bash', 23:19:27 INFO - 'SHLVL': '1', 23:19:27 INFO - 'TERM': 'linux', 23:19:27 INFO - 'TMOUT': '86400', 23:19:27 INFO - 'USER': 'cltbld', 23:19:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:27 INFO - '_': '/tools/buildbot/bin/python'} 23:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:19:28 INFO - Cleaning up... 23:19:28 INFO - Return code: 0 23:19:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:19:28 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')]} 23:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:28 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')]} 23:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:28 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 0x7f296b7cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fd450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', '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 23:19:28 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 23:19:28 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 23:19:28 INFO - Using env: {'DISPLAY': ':0', 23:19:28 INFO - 'HOME': '/home/cltbld', 23:19:28 INFO - 'LANG': 'en_US.UTF-8', 23:19:28 INFO - 'LANGUAGE': 'en_US:en', 23:19:28 INFO - 'LOGNAME': 'cltbld', 23:19:28 INFO - 'MAIL': '/var/mail/cltbld', 23:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:28 INFO - 'MOZ_NO_REMOTE': '1', 23:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:28 INFO - 'NO_EM_RESTART': '1', 23:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:28 INFO - 'PWD': '/builds/slave/test', 23:19:28 INFO - 'SHELL': '/bin/bash', 23:19:28 INFO - 'SHLVL': '1', 23:19:28 INFO - 'TERM': 'linux', 23:19:28 INFO - 'TMOUT': '86400', 23:19:28 INFO - 'USER': 'cltbld', 23:19:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:28 INFO - '_': '/tools/buildbot/bin/python'} 23:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:28 INFO - Downloading/unpacking flake8 23:19:28 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 23:19:28 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 23:19:28 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 23:19:28 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 23:19:28 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 23:19:28 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 23:19:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:19:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:19:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 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 23:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:19:31 INFO - no previously-included directories found matching 'docs/_build' 23:19:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:19:31 INFO - Running setup.py install for pep8 23:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:19:31 INFO - no previously-included directories found matching 'docs/_build' 23:19:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:19:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:19:31 INFO - Cleaning up... 23:19:31 INFO - Return code: 0 23:19:31 INFO - Running post-action listener: _resource_record_post_action 23:19:31 INFO - Running post-action listener: _start_resource_monitoring 23:19:31 INFO - Starting resource monitoring. 23:19:31 INFO - ##### 23:19:31 INFO - ##### Finished create-virtualenv step (success) 23:19:31 INFO - ##### 23:19:31 INFO - ##### 23:19:31 INFO - ##### Running install step. 23:19:31 INFO - ##### 23:19:31 INFO - Running pre-action listener: _resource_record_pre_action 23:19:31 INFO - Running main action method: install 23:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:31 INFO - Reading from file tmpfile_stdout 23:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 23:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:19:31 INFO - Reading from file tmpfile_stdout 23:19:31 INFO - Output received: 23:19:31 INFO - Usage: mozinstall [options] installer 23:19:31 INFO - Options: 23:19:31 INFO - -h, --help show this help message and exit 23:19:31 INFO - -d DEST, --destination=DEST 23:19:31 INFO - Directory to install application into. [default: 23:19:31 INFO - "/builds/slave/test"] 23:19:31 INFO - --app=APP Application being installed. [default: firefox] 23:19:31 INFO - mkdir: /builds/slave/test/build/application 23:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:19:47 INFO - Reading from file tmpfile_stdout 23:19:47 INFO - Output received: 23:19:47 INFO - /builds/slave/test/build/application/firefox/firefox 23:19:47 INFO - Running post-action listener: _resource_record_post_action 23:19:47 INFO - ##### 23:19:47 INFO - ##### Finished install step (success) 23:19:47 INFO - ##### 23:19:47 INFO - ##### 23:19:47 INFO - ##### Running run-tests step. 23:19:47 INFO - ##### 23:19:47 INFO - Running pre-action listener: _resource_record_pre_action 23:19:47 INFO - Running main action method: run_tests 23:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:19:47 INFO - Python 2.7.3 23:19:47 INFO - Return code: 0 23:19:47 INFO - grabbing minidump binary from tooltool 23:19: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')]} 23:19:47 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 0x228c2c0>, '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 0x228d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228d650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:19:47 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 23:19:47 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 23:19:47 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 23:19:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:19:47 INFO - Return code: 0 23:19:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:19:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:19:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:19:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:19:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:19:48 INFO - Return code: 0 23:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:19:48 INFO - Using env: {'DISPLAY': ':0', 23:19:48 INFO - 'HOME': '/home/cltbld', 23:19:48 INFO - 'LANG': 'en_US.UTF-8', 23:19:48 INFO - 'LANGUAGE': 'en_US:en', 23:19:48 INFO - 'LOGNAME': 'cltbld', 23:19:48 INFO - 'MAIL': '/var/mail/cltbld', 23:19:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:19:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:48 INFO - 'MOZ_NO_REMOTE': '1', 23:19:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:48 INFO - 'NO_EM_RESTART': '1', 23:19:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:48 INFO - 'PWD': '/builds/slave/test', 23:19:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:19:48 INFO - 'SHELL': '/bin/bash', 23:19:48 INFO - 'SHLVL': '1', 23:19:48 INFO - 'TERM': 'linux', 23:19:48 INFO - 'TMOUT': '86400', 23:19:48 INFO - 'USER': 'cltbld', 23:19:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911', 23:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:48 INFO - '_': '/tools/buildbot/bin/python'} 23:19:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:19:48 INFO - mozversion application_buildid: 20160702004021 23:19:48 INFO - mozversion application_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 23:19:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:19:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:19:48 INFO - mozversion application_name: Firefox 23:19:48 INFO - mozversion application_remotingname: firefox-dev 23:19:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:19:48 INFO - mozversion application_vendor: Mozilla 23:19:48 INFO - mozversion application_version: 49.0a2 23:19:48 INFO - mozversion platform_buildid: 20160702004021 23:19:48 INFO - mozversion platform_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 23:19:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:19:48 INFO - mozversion platform_version: 49.0a2 23:19:48 INFO - using testdate: 1467526788 23:19:48 INFO - actual date: 1467526788 23:19:48 INFO - starting webserver on 'localhost:52896' 23:19:48 INFO - SUITE-START | Running 2 tests 23:19:48 INFO - TEST-START | dromaeo_css 23:19:48 INFO - operating with platform_type : linux_ 23:19:48 INFO - Initialising browser for dromaeo_css test... 23:19:48 INFO - TEST-INFO | started process 1013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYn42Cx/profile http://localhost:52896/getInfo.html) 23:19:53 INFO - PROCESS | 1013 | __metrics Screen width/height:1600/1200 23:19:53 INFO - PROCESS | 1013 | colorDepth:24 23:19:53 INFO - PROCESS | 1013 | Browser inner width/height: 1024/697 23:19:53 INFO - PROCESS | 1013 | __metrics 23:19:54 ERROR - PROCESS | 1013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:19:54 INFO - TEST-INFO | 1013: exit 0 23:19:54 INFO - Browser initialized. 23:19:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:19:54 INFO - TEST-INFO | started process 1207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYn42Cx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:06 INFO - PROCESS | 1207 | RSS: Main: 156663808 23:20:06 INFO - PROCESS | 1207 | 23:20:56 INFO - PROCESS | 1207 | 1467526856219 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] 23:23:04 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52896/tests/dromaeo/cssquery-ext.html) 23:23:05 INFO - PROCESS | 1207 | RSS: Main: 160137216 23:23:05 INFO - PROCESS | 1207 | 23:26:07 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-ext.html (next: http://localhost:52896/tests/dromaeo/cssquery-jquery.html) 23:26:07 INFO - PROCESS | 1207 | RSS: Main: 157446144 23:26:07 INFO - PROCESS | 1207 | 23:29:09 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52896/tests/dromaeo/cssquery-mootools.html) 23:29:10 INFO - PROCESS | 1207 | RSS: Main: 157691904 23:29:10 INFO - PROCESS | 1207 | 23:32:11 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52896/tests/dromaeo/cssquery-prototype.html) 23:32:12 INFO - PROCESS | 1207 | RSS: Main: 156135424 23:32:12 INFO - PROCESS | 1207 | 23:35:14 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52896/tests/dromaeo/cssquery-yui.html) 23:35:15 INFO - PROCESS | 1207 | RSS: Main: 157556736 23:35:15 INFO - PROCESS | 1207 | 23:38:17 INFO - PROCESS | 1207 | Cycle 1(1): loaded http://localhost:52896/tests/dromaeo/cssquery-yui.html (next: http://localhost:52896/tests/dromaeo/cssquery-dojo.html) 23:38:18 INFO - PROCESS | 1207 | RSS: Main: 158642176 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | __start_tp_report 23:38:18 INFO - PROCESS | 1207 | _x_x_mozilla_page_load 23:38:18 INFO - PROCESS | 1207 | _x_x_mozilla_page_load_details 23:38:18 INFO - PROCESS | 1207 | |i|pagename|runs| 23:38:18 INFO - PROCESS | 1207 | |0;dojo.html;3300.026492184805;3327.800331980083;3372.915677108072;3380.6450322716114;3381;5537.003339398907;5552.211781910795;5571.86070348241;5610.775568977236;5618.353889302732;5589.972050139754;5640.830775076754;5645.322561292651;5646.830595082144;5659.094544872811;5117.027764724699;5204.661696989683;5207.765650545715;5225.477452254782;5251.76367063483;5036.169032109698;5103.744812759366;5260.894782104356;5262.631615786897;5273.657212281209;5154.664946778466;5159.793608255665;5161.509656582619;5178.404483484391;5187.896242075156;5191.4548972357925;5237.607179461536;5238.214267859814;5255.816046438356;5266.34170728659;4956.3804524434445;5007.424146223195;5067.822626208102;5132.127538318495;5139.408967968657;5531.557475401958;5536.086545719952;5552.472515111099;5591.776328946838;5604.775808967636;6044.153818465418;6044.818655440344;6062.787802426894;6064.151018857364;6078.604890682136;5876.265466816648;5992.79025234119;6039.245094363205;6054.334023257438;6108.053251745942;5707.058335374658;5720.427957204288;5723.599348045638;5725.885482290331;5731.99690054243;6190.288116866528;6232.594881332699;6243.125962365272;6252.124702541648;6254.124422580842;5933.258342707161;5944.197533332945;5944.851378715567;5976.462118409277;6044.818655440344;6112.113743507167;6143.907841382383;6144.815655530341;6149.046897730859;6164;5885;6110.663913484801;6116.082587611894;6123.203983482208;6123.510119190454;6005.309389420273;6027.517798576104;6077.4834139098675;6127.816165515042;6133.202683651097;4625.537446255415;4636.397268355092;4644.256918893028;4646.558576935186;4651.325557794168;4050;4082.3672330788777;4165.312723400665;4168.520620128724;4187.560306167869;5695.914561281584;5779.682117483495;5790;5810.738516766755;5873.765049398062;6118.204633397719;6120.14317995481;6123.050927106306;6129.11127886454;6142.6314421134875;5711.029125048752;5821.7380217890295;5868.09044598088;5873.588848780544;5880.705964701748;5043.84868453947;5055.69665820052;5065.544101030851;5092.363454568179;5095.770690318945;6351.142595749515;6382.808515744535;6385.936140638627;6413.6793160341795;6421.101045853584;5898.94101058984;6123.203983482119;6129.417705317987;6156.107364432132;6182.165407669907;6392.744290228525;6402.87194256103;6412.679366031586;6413.134226879311;6421.486281097407;6047.425494578008;6100.6949652516305;6101.664408457577;6107.480864126599;6107.938920610737;5933.436323549256;6012.398760123952;6056.152138700673;6088.26940767093;6199.783007594712;5941.643501389931;5974.731137098754;5977.910331344946;5979.730912108878;5989.880202396015;5894.115882617642;5898.734556945034;5948.762049518144;5961.433663801932;5966.224390829338;5736.799212027559;5762.049261871744;5766.855828604151;5773.076307790733;5857;5925.259342582177;5965.105234214902;5965.701714914324;5965.850853728692;5983.042713165873;5665.801696940587;5859.765609375748;5870.970645146747;5875.823725288248;5890.793822216202 23:38:18 INFO - PROCESS | 1207 | |1;ext.html;580.6138917619783;643.8808820368231;655.1450357283743;666.4068978609038;679.6363945289271;40493.797531012344;45104.3234351485;45123.999999999956;45142.77428612852;45426.7728661357;46880.76559617206;47322.52677473233;47421.288680669815;47453.52546474534;47572;9028.954855225747;9102.908970910305;9111.40775849571;9175.036621154783;9179.908200918006;9017.864732029026;9084.77288067797;9145.634174633007;9173.908260917406;9182.127697868726;9068.319876009293;9174.08259174084;9177.954110229439;9181.40320879144;9181.632734690604;9116.772080698003;9181.219596334286;9190.402623829497;9192.264618830512;9209.401388909699;9005;9015.504147271897;9030.503322317336;9034.09659034098;9091.181793638605;42657.146857062995;42976.57023429757;43002.13995720068;43030;43397.349039764114;3553.4136867416846;3914.902127446808;4000;4089.591040895916;4496.7301961882395;34528.654713452794;34798;34812.477812832825;35045.47431788525;36199;4811.78346974387;4819.9036019279765;4821.204501257288;4865.318855360252;4885.828995985124;394988;397247;399104;399545;402519.98740006407;62186;62313.376866231665;62740;62754;62817.057744133876;39253;39970;40034.79982600127;42411;42695.35956960648;18001.459956201335;18070.5482362942;18221.088945552936;18225.908870455827;18272.177752000927;13597.660058498617;13643.931780341234;13691.49393566707;13691.520796772264;13794.65513362154;21054.578908421747;21100.78899211019;21121.78878211229;21304.680429793567;21490.892545537172;7654.770356889302;7701.767717165227;7713.65288562016;7780.8054798629355;7814.765557033298;1065.4353192807823;1125.7241975716001;1170.8594968603823;1186.371223251678;1228.8893999540085;34171.14572135716;34194.31611367759;34379;34577.30845383078;35270.82364588212;1167.8598568171874;1191.2137988927266;1205.421397729095;1218.6161359171833;1233.105998151351;17954.461366159037;18128.818711812713;18150;18231.63536729258;18288.17703203359;624271;984927;1015686;1166273;1186791;62039.37960620336;62281;62631;62632;63230;1465.7141857337717;1483.9035462694674;1484.1614487814566;1487.7024595081027;1504.353128154882;32621.836890815393;32935;33274;33578.66421335755;34177.65822341745;53950;54447;54501;54539.72730136483;54618;473426;475039;478320.2167978415;478423;478887;30140.547891781203;30244;30461.086167415015;30654.080377588707;30800.383992320476;48188;48493.75753121212;48947.265791012454;50065;50582.49417505925;43746.34380484359;43952.78023609862;46533.76733116313;48947.755261223465;49578.25632615586;45154.322685159095;45308.773456132505;45742.313865291384;45849;46970.76514617405;44960;45378.77310613426;45460;45897.54102458933;45942;37739.245215095;39231.60768392394;39306.803465982484;39811.80094099627;40189.79905100456;29909;30553.23616909595;31037.534436983013;31086.37827243488;31093.22266943254 23:38:18 INFO - PROCESS | 1207 | |2;jquery.html;413.23963906412195;414.69105516390283;416.2819136988695;419.75024860208174;437.5121739260723;19562.90218548907;19785.307514236985;20514.076866541003;21687.566248675015;21802.345929622097;13525.256110913895;17327.566810829736;19323.613527729438;20196;20228.39314820554;5400.189971504266;5566.443355664442;5578.079616863212;5590.720463976785;5601.60788744788;5426.511613954744;5497.890042199154;6037.667928263966;6038.5471089668235;6039.124326972608;5932.169496270526;5984.401559844025;5984.850378740544;5990.221271234734;6005.1892994445625;5761;5990.251218597676;6005.069214271773;6007.038873780218;6024.759009639631;5192.273081768555;5406.297181366436;5408.2698835657075;5420.186971954238;5433.239346491455;14488.420463181461;14841.480548180869;14916.477923272634;14989.850101498954;18422.539436514195;2329.138218859033;2428.6842710447704;2506.260653107338;2599.1163004578534;2826.844523551204;11019.559217631286;11024.559017639365;11096.611618593392;11144.498497567629;14761.819054475616;2039.4901274681329;2051.138521820839;2084.718562993992;2096.8846713430753;2113.7569179544244;90240.54879725626;90465;92235.53882230613;92284;92593.53703231509;11884.168108232341;11888.405579720978;11909;12057.879421205851;12165.93917030427;13075.738485230433;17006.744898826528;17016.31934722622;17024.063676497663;17024.233909474104;8042.276195142465;8135.30849877767;8388.916110838814;8430;8540.487570745776;8207.589620518951;8213.34293256538;8335.583220838933;8521.147885211552;8678.262347700516;4318.632916202158;4349.173657005159;4356.586124318184;4388.517263101056;4402.25161722508;2033.542452948075;2072.4611600983553;2096.874187548752;2108.3780284816016;2133.8826364549786;486.76878482721133;1037.870266216723;1136.959681891077;1144.1933436927113;1187.7980743273665;12273.570425035081;12827.679308017188;12928.095033347576;12998.870011299956;13087.280199588924;502.6607040247818;506.88341681412743;523.2883278740909;524.1865429004026;525.6688286379556;6625.734970601218;6745.291744366869;6801.65991700413;6909.965450172717;6934.514583979073;566262;580047.1995280078;586844;614989;662086;106127.46936265424;106883.46558267159;107608;108095.45952270189;109137;495.63946965579714;498.48157915767194;501.7340809371039;505.4137200847;508.10319785578486;11311.208215424842;11755.177137600627;11790.587329443428;11887.762244754884;11956.641300760992;41285;43197.78401107974;43652.34521482244;43666.126677466906;44316.33525497185;56919;59706.40293597009;65625.34374656383;65770.67114664396;65895.67052164709;8803.427777194462;9000.459972401677;9177.449353038839;9303.255739540957;9344.6917431561;13565.389557470135;14171.787423188454;14216;14252.786208206679;14607.196604186447;12640.936795315965;12654.810177847523;12761.93619031899;12867.742645147231;12891.226526408445;12355;12579.433925473193;12672.176308539916;12744.872551274368;12860.549880754128;12850.742985140057;12860.2926839021;12961.481540738265;13055.412506437044;13187.274699891597;8923.196912277666;8943.910560894308;8951.41815781998;8963.641454341754;9010.504422256576;9587.856182157413;13087.345632718516;13102.475900963855;13167.60497185086;13268.336583170996 23:38:18 INFO - PROCESS | 1207 | |3;mootools.html;1520.5818399940015;1564.7339952208126;1742.8431441170292;1883.8304552590264;1904.6857268550698;8180.100188979208;8703.825923481527;8703.956480217597;9265.814683706321;9274.072592740731;8706.956465217681;8906.86639700405;9091.72724818255;9106.499142547158;9116.8632470513;2298.310506847943;2325.011869955271;2345.8944347504403;2349.8472599281076;2352.517733864562;2362.6337917622795;2366.4912043910554;2400.603900356448;2406.109739396426;2414.082648593541;2354.211339201361;2355.34050465869;2355.9764402355927;2372.0037584214583;2389.3668177932773;2244.259394399844;2247.584196923566;2256.9435764105865;2264.1056782570877;2282.589133955887;2250.561140577588;2252.1329288223988;2253.6506841439605;2257.9096836126537;2262.9434264143365;8862.734117976472;9044.54777261141;9067.54662266884;9077.909220907772;9082.954585227099;5379.354477462691;5496.258005169291;5521.585881058937;5522.337319521643;5556;3453.4992426098324;3531.876384326562;3550.6981906537976;3638.6543278388513;3662.34077865984;1115.3865374044244;1122.0518661730905;1136.8294755786615;1178.917475776696;1181.314837394318;13072.215667060007;13163.67090822737;13166.539171128965;13185.208887466782;13247.602571922858;4803.519648035169;4824.589909857631;4912.189488734391;4912.312276281324;4915.16442204826;10951.4524273786;11011.174161937886;11027.2280940335;11033.889661103447;11122.332660040423;5520.66875987434;5541.889162216814;5563.66618002913;5598.300212473441;5619.578531610146;4518.615917647036;5019.67372120811;5135.35808023997;5183.3261675981885;5194.1429664105;4225.619694227473;4235.131797981407;4237.618614324726;4263.445752052276;4301.65586753059;1286.067600989294;1333.9066265361332;1334.9132306400054;1342.4630147940902;1349.62885206569;1054.6625079974488;1056.3239526702916;1057.772578895541;1064.4039337970762;1066.7119877632995;6368;6596.406323430914;6695.12963314766;6742.764003259862;6747.527673062838;464.7118786352483;467.28505386758314;473.01612645696866;473.8436316015707;493.41530286609765;4558.111168322212;4574.245249533789;4615.95384046162;4623.69945953512;4630.236011058205;10895.400752958663;11156.051735602403;11172.162087843444;11202.719932001764;11230.550777968952;11041.39272340029;11127.165462590337;11131.610393636183;11161.441927903572;11363.318200907972;8683.696070637498;8782.297416206688;8818.691345802867;8856.3800533962;8863.911360886308;6646.335366463315;6875.0718652983205;6931.826704332432;6932.376086152069;6932.792016239521;10325.74185645365;10676.893231067901;10690.305130166515;10743.785124297627;10784;11018.44907754593;11102.777944440904;11124.833127503256;11165.274257173258;11259.662210133709;7590.127135379502;7869.449138560246;8049.959750201211;8368.246857782586;8556.229939305493;8409.2431681149;8496;8499.660013599387;8501.234888860032;8539.188777066169;7713.344365728976;8067.798305042421;8163.061247956323;8164.7550573482895;8261.463004904663;7966.800829979297;8149.674013039412;8274.462159959583;8368.748937531884;8382.83234335322;7021.806292930316;7094.077769889881;7172.605506697182;7183.640817958976;7220.277972202738;5744.224529688438;5757.251557297692;5842.737076831638;5865.794697185578;5893.705314734332;5723.8855222896145;5834.795782147605;5841.561882858888;5854.443827836349;5979.4917432018765 23:38:18 INFO - PROCESS | 1207 | |4;prototype.html;340.8295852073963;343.0737010072804;343.48305799771356;355.8683287183742;356.95181150544676;5775.422457754223;5787;5787.971060144699;5798.420157984199;5838.416158384154;5717.828465146053;5742.942570574293;5758.3588677227;5762.193292938981;5775.768969241236;4270.231358355495;4505.932411013838;4508.684392092555;4517.887052823689;4529.728216307016;4480.148771733377;4547.249703798886;4573.131105090022;4573.725576465423;4578.496365399803;4495.213337665896;4529.841455549056;4533.818647254106;4544.545545445446;4549.61328287096;4448.955510444886;4470.664700147502;4500.559820857327;4504.121696269212;4509.1883460977015;3958.148997965451;3987.4249671379935;4003.259397011562;4009.8797036088963;4017.2367250222364;5357.81247656334;5499.587530935196;5596.4403559644115;5625.971870140623;5633.718314084321;5079.74601269935;5158.819441319536;5171.405288391846;5217.426083130853;5239.087732977436;6019.789307374221;6032.819015429544;6036.3360030396625;6050.364711705296;6136.386361363872;4387.802548885308;4465.419495465601;4511.1654343946475;4518.728876267434;4522.276435770261;6147.600405973598;6298.937010629927;6326.905096423558;6328.493720502394;6396.6162030277865;4457.554244575581;4467.329900514948;4491.281394976788;4493.5281795411665;4505.707129036602;4515.458145022552;4529.773511324486;4531.478879928851;4537.546245375436;4548.56788605082;5077.949220507748;5115.311947057462;5144.43411224765;5180.974095129575;5200.323957885451;6023.427774361428;6094.329623741385;6103.1455596216565;6106.694665266719;6111.266648002268;1591.610055536401;1595.6250281183914;1607.3088571913956;1631.5023917705214;1631.7470792027254;1020.8570800087845;1047.7223535763028;1061.4215252687304;1065.8667666541683;1073.3774410841693;5920.526357891358;5927.911081333784;5934.673592952429;5952.434518720715;5969.432903874125;6102.9694851525455;6173.876522469525;6200.906986395207;6230.875382492415;6251.531135164881;5739.397363276796;5802.3037235531165;5865.912011319833;5890.175375447441;5998.310194327621;3299.0762586475344;3321.684439978198;3323.4848598467274;3333.5499707539657;3346.7657263991773;6194.287656919422;6409.711562979677;6450.290468048511;6597.868042639217;6613.966930165415;6431.614103153732;6441.64570948593;6461.8061458156335;6467.935320646828;6481;6305.842353941188;6518.73925042993;6559.934400656028;6583.473322134314;6610.182199894971;6336.398042185985;6349.111124442489;6372;6379.904301435575;6393.1688880445245;5923.733431995657;6261.966775481995;6277.5605707600025;6292.182016337847;6301.306856245717;6470.6735119301375;6556.475481961336;6591.307912669101;6597.977313516412;6662.966685166543;4466.4640243171025;4511.954880451153;4522.660800440046;4522.909541809211;4538.160440318552;6201.108661857997;6266.310705822265;6310.968445157929;6329.430351268408;6455.4512866405;6123.632582045091;6158.353372895782;6226.688665566794;6242.781502647385;6252.9370007099815;5905.291365036223;6121.969390153021;6133.141360209485;6139.723712432862;6169.722362493609;6050.878982420415;6060.878782424415;6070.514358851193;6091;6107.755689772359;6124.877502449837;6175.536834737323;6214.751409943552;6230.376962303733;6242.65665388408;5861.501772349398;6077.756889724538;6090.665013424305;6101.993171126892;6116.816495505142 23:38:18 INFO - PROCESS | 1207 | |5;yui.html;725.9491835571512;746.3059354800034;795.2921899509438;888.4580405952368;914.6021480655913;13974;14747.41010359587;14931.701365972674;15271.847281527182;15469.767953480692;15224.162671053115;15266;15311.77032344513;15381.769273460879;15423.845761542381;840.8906842110517;845.5476320168711;861.4357595774777;866.7096522664915;869.9782505437352;852.3820230333021;858.6908712863365;860.5482121885997;860.7977125375531;862.3747782857441;880.995595022024;881.9691310804124;882.9249513791335;887.0021226120614;888.2272422992006;873.9082396348388;876.9473831570094;877.4384393987852;877.6094637886143;878.8066625342415;654.4731491149622;655.5673255651247;660.0824853453655;660.3066779881106;662.0069895157264;15927.124008179546;16038.278277477542;16067.517974460785;16073.196340182943;16090;13033.608991730263;14336.928315358356;14772.630684232872;15055.47305844301;16247.02517848921;13038.024656808657;13580;13705.314734263347;13862.098963567336;13863.653408664763;4814.109389762905;4842.055799119174;4897.975510122426;4905.068037072945;4923.975380123076;79478;79958;80016.59991700063;81025.59487202526;81610.18389816085;11478.196526243082;11908.404579770977;12036.39818009096;12081.582904155664;12142.08934329911;23179;23268;23272.3018309451;23286.767132328798;23482.295531134092;9321.95339023314;9339.439633622005;9358.298127640453;9423.575939082757;9596.424214547149;4467.865964021084;4687.296905464208;4707.223308154116;4856.39295088114;4903.632227582945;3506.8421921013614;3633.3459977204357;3634.545681789776;3651.507046548682;3651.561812582507;638.543441439373;657.5298661456985;658.236445722959;661.490652197805;666.0608541955819;582.525241927836;663.2637772072995;686.8030061219363;724.2142275630894;728.1553398058227;9214.815703685888;9407.2003879671;9476.905230947741;9534.475603841716;9816.263780216512;508.3493128795148;685.9984422742851;718.6263143165525;756.5120497279224;770.9884351734728;4726.669133160645;4809.110314591811;4936.136176169156;4980.526849949249;4991.3511243538105;72523.2747672527;73086.269137309;73159;118029;123887;89911.55044224738;91862;100368;101789.49105254427;101981;93248.53375733078;93754.0624593759;94122;95860.52069739606;100183;10000.849987250343;10048.145907597936;10324.638637647646;10341.37951722899;10391.84412233802;46308.7684561575;49133.50866491289;49573.504264958334;54955.175672365745;55130.17304740352;73521;73648;81662.59168704356;81853.59073204834;81926.18073819423;12562.497500099893;12595.685107872376;12727.172733772275;13988.37052332668;14400.639984000483;15008.099514029193;15045.699086018438;16004.119773412574;16035.919820400823;16071.758923615922;12765.234085954873;14024.158550487004;14213.289335533389;14297.64255893611;14769.778453322993;14153.363098660791;14163.150210987375;14299.928500357431;14659.853401466275;14910.701785964004;11725.589604363806;12995.155314904501;13038.087333886537;14214;14245.21651309188;11804.080581836919;11835.644930652094;12288.1398302118;12327.383630818602;12453.315067671003;11918.344491053076;11974.401279936143;12092;12124.211926224767;12240.75518489643 23:38:18 INFO - PROCESS | 1207 | __end_tp_report 23:38:18 INFO - PROCESS | 1207 | __start_cc_report 23:38:18 INFO - PROCESS | 1207 | _x_x_mozilla_cycle_collect,327 23:38:18 INFO - PROCESS | 1207 | __end_cc_report 23:38:18 INFO - PROCESS | 1207 | __startTimestamp1467527898013__endTimestamp 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | ------- Summary: start ------- 23:38:18 INFO - PROCESS | 1207 | Number of tests: 6 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#0] dojo.html Cycles:165 Average:5648.20 Median:5875.82 stddev:649.75 (11.1%) stddev-sans-first:625.09 23:38:18 INFO - PROCESS | 1207 | Values: 3300.0 3327.8 3372.9 3380.6 3381.0 5537.0 5552.2 5571.9 5610.8 5618.4 5590.0 5640.8 5645.3 5646.8 5659.1 5117.0 5204.7 5207.8 5225.5 5251.8 5036.2 5103.7 5260.9 5262.6 5273.7 5154.7 5159.8 5161.5 5178.4 5187.9 5191.5 5237.6 5238.2 5255.8 5266.3 4956.4 5007.4 5067.8 5132.1 5139.4 5531.6 5536.1 5552.5 5591.8 5604.8 6044.2 6044.8 6062.8 6064.2 6078.6 5876.3 5992.8 6039.2 6054.3 6108.1 5707.1 5720.4 5723.6 5725.9 5732.0 6190.3 6232.6 6243.1 6252.1 6254.1 5933.3 5944.2 5944.9 5976.5 6044.8 6112.1 6143.9 6144.8 6149.0 6164.0 5885.0 6110.7 6116.1 6123.2 6123.5 6005.3 6027.5 6077.5 6127.8 6133.2 4625.5 4636.4 4644.3 4646.6 4651.3 4050.0 4082.4 4165.3 4168.5 4187.6 5695.9 5779.7 5790.0 5810.7 5873.8 6118.2 6120.1 6123.1 6129.1 6142.6 5711.0 5821.7 5868.1 5873.6 5880.7 5043.8 5055.7 5065.5 5092.4 5095.8 6351.1 6382.8 6385.9 6413.7 6421.1 5898.9 6123.2 6129.4 6156.1 6182.2 6392.7 6402.9 6412.7 6413.1 6421.5 6047.4 6100.7 6101.7 6107.5 6107.9 5933.4 6012.4 6056.2 6088.3 6199.8 5941.6 5974.7 5977.9 5979.7 5989.9 5894.1 5898.7 5948.8 5961.4 5966.2 5736.8 5762.0 5766.9 5773.1 5857.0 5925.3 5965.1 5965.7 5965.9 5983.0 5665.8 5859.8 5871.0 5875.8 5890.8 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#1] ext.html Cycles:180 Average:76513.75 Median:24728.37 stddev:186381.53 (753.7%) stddev-sans-first:186817.18 23:38:18 INFO - PROCESS | 1207 | Values: 580.6 643.9 655.1 666.4 679.6 40493.8 45104.3 45124.0 45142.8 45426.8 46880.8 47322.5 47421.3 47453.5 47572.0 9029.0 9102.9 9111.4 9175.0 9179.9 9017.9 9084.8 9145.6 9173.9 9182.1 9068.3 9174.1 9178.0 9181.4 9181.6 9116.8 9181.2 9190.4 9192.3 9209.4 9005.0 9015.5 9030.5 9034.1 9091.2 42657.1 42976.6 43002.1 43030.0 43397.3 3553.4 3914.9 4000.0 4089.6 4496.7 34528.7 34798.0 34812.5 35045.5 36199.0 4811.8 4819.9 4821.2 4865.3 4885.8 394988.0 397247.0 399104.0 399545.0 402520.0 62186.0 62313.4 62740.0 62754.0 62817.1 39253.0 39970.0 40034.8 42411.0 42695.4 18001.5 18070.5 18221.1 18225.9 18272.2 13597.7 13643.9 13691.5 13691.5 13794.7 21054.6 21100.8 21121.8 21304.7 21490.9 7654.8 7701.8 7713.7 7780.8 7814.8 1065.4 1125.7 1170.9 1186.4 1228.9 34171.1 34194.3 34379.0 34577.3 35270.8 1167.9 1191.2 1205.4 1218.6 1233.1 17954.5 18128.8 18150.0 18231.6 18288.2 624271.0 984927.0 1015686.0 1166273.0 1186791.0 62039.4 62281.0 62631.0 62632.0 63230.0 1465.7 1483.9 1484.2 1487.7 1504.4 32621.8 32935.0 33274.0 33578.7 34177.7 53950.0 54447.0 54501.0 54539.7 54618.0 473426.0 475039.0 478320.2 478423.0 478887.0 30140.5 30244.0 30461.1 30654.1 30800.4 48188.0 48493.8 48947.3 50065.0 50582.5 43746.3 43952.8 46533.8 48947.8 49578.3 45154.3 45308.8 45742.3 45849.0 46970.8 44960.0 45378.8 45460.0 45897.5 45942.0 37739.2 39231.6 39306.8 39811.8 40189.8 29909.0 30553.2 31037.5 31086.4 31093.2 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#2] jquery.html Cycles:180 Average:32634.50 Median:415.49 stddev:99483.77 (23943.9%) stddev-sans-first:99733.43 23:38:18 INFO - PROCESS | 1207 | Values: 413.2 414.7 416.3 419.8 437.5 19562.9 19785.3 20514.1 21687.6 21802.3 13525.3 17327.6 19323.6 20196.0 20228.4 5400.2 5566.4 5578.1 5590.7 5601.6 5426.5 5497.9 6037.7 6038.5 6039.1 5932.2 5984.4 5984.9 5990.2 6005.2 5761.0 5990.3 6005.1 6007.0 6024.8 5192.3 5406.3 5408.3 5420.2 5433.2 14488.4 14841.5 14916.5 14989.9 18422.5 2329.1 2428.7 2506.3 2599.1 2826.8 11019.6 11024.6 11096.6 11144.5 14761.8 2039.5 2051.1 2084.7 2096.9 2113.8 90240.5 90465.0 92235.5 92284.0 92593.5 11884.2 11888.4 11909.0 12057.9 12165.9 13075.7 17006.7 17016.3 17024.1 17024.2 8042.3 8135.3 8388.9 8430.0 8540.5 8207.6 8213.3 8335.6 8521.1 8678.3 4318.6 4349.2 4356.6 4388.5 4402.3 2033.5 2072.5 2096.9 2108.4 2133.9 486.8 1037.9 1137.0 1144.2 1187.8 12273.6 12827.7 12928.1 12998.9 13087.3 502.7 506.9 523.3 524.2 525.7 6625.7 6745.3 6801.7 6910.0 6934.5 566262.0 580047.2 586844.0 614989.0 662086.0 106127.5 106883.5 107608.0 108095.5 109137.0 495.6 498.5 501.7 505.4 508.1 11311.2 11755.2 11790.6 11887.8 11956.6 41285.0 43197.8 43652.3 43666.1 44316.3 56919.0 59706.4 65625.3 65770.7 65895.7 8803.4 9000.5 9177.4 9303.3 9344.7 13565.4 14171.8 14216.0 14252.8 14607.2 12640.9 12654.8 12761.9 12867.7 12891.2 12355.0 12579.4 12672.2 12744.9 12860.5 12850.7 12860.3 12961.5 13055.4 13187.3 8923.2 8943.9 8951.4 8963.6 9010.5 9587.9 13087.3 13102.5 13167.6 13268.3 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#3] mootools.html Cycles:180 Average:6105.42 Median:2547.47 stddev:3481.51 (136.7%) stddev-sans-first:3474.23 23:38:18 INFO - PROCESS | 1207 | Values: 1520.6 1564.7 1742.8 1883.8 1904.7 8180.1 8703.8 8704.0 9265.8 9274.1 8707.0 8906.9 9091.7 9106.5 9116.9 2298.3 2325.0 2345.9 2349.8 2352.5 2362.6 2366.5 2400.6 2406.1 2414.1 2354.2 2355.3 2356.0 2372.0 2389.4 2244.3 2247.6 2256.9 2264.1 2282.6 2250.6 2252.1 2253.7 2257.9 2262.9 8862.7 9044.5 9067.5 9077.9 9083.0 5379.4 5496.3 5521.6 5522.3 5556.0 3453.5 3531.9 3550.7 3638.7 3662.3 1115.4 1122.1 1136.8 1178.9 1181.3 13072.2 13163.7 13166.5 13185.2 13247.6 4803.5 4824.6 4912.2 4912.3 4915.2 10951.5 11011.2 11027.2 11033.9 11122.3 5520.7 5541.9 5563.7 5598.3 5619.6 4518.6 5019.7 5135.4 5183.3 5194.1 4225.6 4235.1 4237.6 4263.4 4301.7 1286.1 1333.9 1334.9 1342.5 1349.6 1054.7 1056.3 1057.8 1064.4 1066.7 6368.0 6596.4 6695.1 6742.8 6747.5 464.7 467.3 473.0 473.8 493.4 4558.1 4574.2 4616.0 4623.7 4630.2 10895.4 11156.1 11172.2 11202.7 11230.6 11041.4 11127.2 11131.6 11161.4 11363.3 8683.7 8782.3 8818.7 8856.4 8863.9 6646.3 6875.1 6931.8 6932.4 6932.8 10325.7 10676.9 10690.3 10743.8 10784.0 11018.4 11102.8 11124.8 11165.3 11259.7 7590.1 7869.4 8050.0 8368.2 8556.2 8409.2 8496.0 8499.7 8501.2 8539.2 7713.3 8067.8 8163.1 8164.8 8261.5 7966.8 8149.7 8274.5 8368.7 8382.8 7021.8 7094.1 7172.6 7183.6 7220.3 5744.2 5757.3 5842.7 5865.8 5893.7 5723.9 5834.8 5841.6 5854.4 5979.5 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#4] prototype.html Cycles:180 Average:5159.19 Median:5820.36 stddev:1519.76 (26.1%) stddev-sans-first:1480.37 23:38:18 INFO - PROCESS | 1207 | Values: 340.8 343.1 343.5 355.9 357.0 5775.4 5787.0 5788.0 5798.4 5838.4 5717.8 5742.9 5758.4 5762.2 5775.8 4270.2 4505.9 4508.7 4517.9 4529.7 4480.1 4547.2 4573.1 4573.7 4578.5 4495.2 4529.8 4533.8 4544.5 4549.6 4449.0 4470.7 4500.6 4504.1 4509.2 3958.1 3987.4 4003.3 4009.9 4017.2 5357.8 5499.6 5596.4 5626.0 5633.7 5079.7 5158.8 5171.4 5217.4 5239.1 6019.8 6032.8 6036.3 6050.4 6136.4 4387.8 4465.4 4511.2 4518.7 4522.3 6147.6 6298.9 6326.9 6328.5 6396.6 4457.6 4467.3 4491.3 4493.5 4505.7 4515.5 4529.8 4531.5 4537.5 4548.6 5077.9 5115.3 5144.4 5181.0 5200.3 6023.4 6094.3 6103.1 6106.7 6111.3 1591.6 1595.6 1607.3 1631.5 1631.7 1020.9 1047.7 1061.4 1065.9 1073.4 5920.5 5927.9 5934.7 5952.4 5969.4 6103.0 6173.9 6200.9 6230.9 6251.5 5739.4 5802.3 5865.9 5890.2 5998.3 3299.1 3321.7 3323.5 3333.5 3346.8 6194.3 6409.7 6450.3 6597.9 6614.0 6431.6 6441.6 6461.8 6467.9 6481.0 6305.8 6518.7 6559.9 6583.5 6610.2 6336.4 6349.1 6372.0 6379.9 6393.2 5923.7 6262.0 6277.6 6292.2 6301.3 6470.7 6556.5 6591.3 6598.0 6663.0 4466.5 4512.0 4522.7 4522.9 4538.2 6201.1 6266.3 6311.0 6329.4 6455.5 6123.6 6158.4 6226.7 6242.8 6252.9 5905.3 6122.0 6133.1 6139.7 6169.7 6050.9 6060.9 6070.5 6091.0 6107.8 6124.9 6175.5 6214.8 6230.4 6242.7 5861.5 6077.8 6090.7 6102.0 6116.8 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - PROCESS | 1207 | [#5] yui.html Cycles:180 Average:20929.70 Median:4767.89 stddev:29233.85 (613.1%) stddev-sans-first:29276.50 23:38:18 INFO - PROCESS | 1207 | Values: 725.9 746.3 795.3 888.5 914.6 13974.0 14747.4 14931.7 15271.8 15469.8 15224.2 15266.0 15311.8 15381.8 15423.8 840.9 845.5 861.4 866.7 870.0 852.4 858.7 860.5 860.8 862.4 881.0 882.0 882.9 887.0 888.2 873.9 876.9 877.4 877.6 878.8 654.5 655.6 660.1 660.3 662.0 15927.1 16038.3 16067.5 16073.2 16090.0 13033.6 14336.9 14772.6 15055.5 16247.0 13038.0 13580.0 13705.3 13862.1 13863.7 4814.1 4842.1 4898.0 4905.1 4924.0 79478.0 79958.0 80016.6 81025.6 81610.2 11478.2 11908.4 12036.4 12081.6 12142.1 23179.0 23268.0 23272.3 23286.8 23482.3 9322.0 9339.4 9358.3 9423.6 9596.4 4467.9 4687.3 4707.2 4856.4 4903.6 3506.8 3633.3 3634.5 3651.5 3651.6 638.5 657.5 658.2 661.5 666.1 582.5 663.3 686.8 724.2 728.2 9214.8 9407.2 9476.9 9534.5 9816.3 508.3 686.0 718.6 756.5 771.0 4726.7 4809.1 4936.1 4980.5 4991.4 72523.3 73086.3 73159.0 118029.0 123887.0 89911.6 91862.0 100368.0 101789.5 101981.0 93248.5 93754.1 94122.0 95860.5 100183.0 10000.8 10048.1 10324.6 10341.4 10391.8 46308.8 49133.5 49573.5 54955.2 55130.2 73521.0 73648.0 81662.6 81853.6 81926.2 12562.5 12595.7 12727.2 13988.4 14400.6 15008.1 15045.7 16004.1 16035.9 16071.8 12765.2 14024.2 14213.3 14297.6 14769.8 14153.4 14163.2 14299.9 14659.9 14910.7 11725.6 12995.2 13038.1 14214.0 14245.2 11804.1 11835.6 12288.1 12327.4 12453.3 11918.3 11974.4 12092.0 12124.2 12240.8 23:38:18 INFO - PROCESS | 1207 | -------- Summary: end -------- 23:38:18 INFO - PROCESS | 1207 | 23:38:18 INFO - TEST-INFO | 1207: exit 0 23:38:18 INFO - TEST-OK | dromaeo_css | took 1110011ms 23:38:18 INFO - TEST-START | kraken 23:38:18 INFO - operating with platform_type : linux_ 23:38:18 INFO - Initialising browser for kraken test... 23:38:18 INFO - TEST-INFO | started process 1462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppinVqo/profile http://localhost:52896/getInfo.html) 23:38:22 INFO - PROCESS | 1462 | __metrics Screen width/height:1600/1200 23:38:22 INFO - PROCESS | 1462 | colorDepth:24 23:38:22 INFO - PROCESS | 1462 | Browser inner width/height: 1024/697 23:38:23 INFO - PROCESS | 1462 | __metrics 23:38:23 ERROR - PROCESS | 1462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:38:24 INFO - TEST-INFO | 1462: exit 0 23:38:24 INFO - Browser initialized. 23:38:24 INFO - Running cycle 1/1 for kraken test... 23:38:24 INFO - TEST-INFO | started process 1592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppinVqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:36 INFO - PROCESS | 1592 | RSS: Main: 155963392 23:38:36 INFO - PROCESS | 1592 | 23:38:38 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52896/tests/kraken/driver.html?testName=audio-beat-detection) 23:38:39 INFO - PROCESS | 1592 | RSS: Main: 161488896 23:38:39 INFO - PROCESS | 1592 | 23:38:42 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52896/tests/kraken/driver.html?testName=audio-dft) 23:38:42 INFO - PROCESS | 1592 | RSS: Main: 160256000 23:38:42 INFO - PROCESS | 1592 | 23:38:45 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52896/tests/kraken/driver.html?testName=audio-fft) 23:38:46 INFO - PROCESS | 1592 | RSS: Main: 162050048 23:38:46 INFO - PROCESS | 1592 | 23:38:48 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52896/tests/kraken/driver.html?testName=audio-oscillator) 23:38:49 INFO - PROCESS | 1592 | RSS: Main: 161136640 23:38:49 INFO - PROCESS | 1592 | 23:38:51 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:38:51 INFO - PROCESS | 1592 | RSS: Main: 161148928 23:38:51 INFO - PROCESS | 1592 | 23:38:55 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52896/tests/kraken/driver.html?testName=imaging-darkroom) 23:38:55 INFO - PROCESS | 1592 | RSS: Main: 160309248 23:38:55 INFO - PROCESS | 1592 | 23:38:59 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52896/tests/kraken/driver.html?testName=imaging-desaturate) 23:38:59 INFO - PROCESS | 1592 | RSS: Main: 161734656 23:38:59 INFO - PROCESS | 1592 | 23:39:02 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52896/tests/kraken/driver.html?testName=json-parse-financial) 23:39:03 INFO - PROCESS | 1592 | RSS: Main: 161247232 23:39:03 INFO - PROCESS | 1592 | 23:39:04 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:39:05 INFO - PROCESS | 1592 | RSS: Main: 161173504 23:39:05 INFO - PROCESS | 1592 | 23:39:07 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:39:07 INFO - PROCESS | 1592 | RSS: Main: 160481280 23:39:07 INFO - PROCESS | 1592 | 23:39:09 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:39:10 INFO - PROCESS | 1592 | RSS: Main: 160604160 23:39:10 INFO - PROCESS | 1592 | 23:39:12 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:39:13 INFO - PROCESS | 1592 | RSS: Main: 161349632 23:39:13 INFO - PROCESS | 1592 | 23:39:16 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:39:16 INFO - PROCESS | 1592 | RSS: Main: 160845824 23:39:16 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | Cycle 1(1): loaded http://localhost:52896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52896/tests/kraken/driver.html?testName=ai-astar) 23:39:18 INFO - PROCESS | 1592 | RSS: Main: 161857536 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | __start_tp_report 23:39:18 INFO - PROCESS | 1592 | _x_x_mozilla_page_load 23:39:18 INFO - PROCESS | 1592 | _x_x_mozilla_page_load_details 23:39:18 INFO - PROCESS | 1592 | |i|pagename|runs| 23:39:18 INFO - PROCESS | 1592 | |0;ai-astar;112;104;111;114;116;111;109;110;111;111 23:39:18 INFO - PROCESS | 1592 | |1;audio-beat-detection;151;125;153;179;126;165;159;125;178;128 23:39:18 INFO - PROCESS | 1592 | |2;audio-dft;163;161;163;162;163;162;163;163;161;161 23:39:18 INFO - PROCESS | 1592 | |3;audio-fft;77;75;77;175;75;74;76;75;168;78 23:39:18 INFO - PROCESS | 1592 | |4;audio-oscillator;86;84;149;85;86;85;138;86;85;154 23:39:18 INFO - PROCESS | 1592 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;117;118;117 23:39:18 INFO - PROCESS | 1592 | |6;imaging-darkroom;147;147;147;146;147;147;147;149;148;146 23:39:18 INFO - PROCESS | 1592 | |7;imaging-desaturate;95;96;95;96;95;96;96;94;96;96 23:39:18 INFO - PROCESS | 1592 | |8;json-parse-financial;51;65;53;53;52;58;53;56;52;54 23:39:18 INFO - PROCESS | 1592 | |9;json-stringify-tinderbox;59;60;68;59;60;59;59;61;60;60 23:39:18 INFO - PROCESS | 1592 | |10;stanford-crypto-aes;76;76;83;82;81;77;78;77;110;79 23:39:18 INFO - PROCESS | 1592 | |11;stanford-crypto-ccm;121;118;119;116;126;125;123;123;125;123 23:39:18 INFO - PROCESS | 1592 | |12;stanford-crypto-pbkdf2;156;156;171;154;156;156;156;154;157;155 23:39:18 INFO - PROCESS | 1592 | |13;stanford-crypto-sha256-iterative;64;63;64;63;63;62;63;65;65;63 23:39:18 INFO - PROCESS | 1592 | __end_tp_report 23:39:18 INFO - PROCESS | 1592 | __start_cc_report 23:39:18 INFO - PROCESS | 1592 | _x_x_mozilla_cycle_collect,894 23:39:18 INFO - PROCESS | 1592 | __end_cc_report 23:39:18 INFO - PROCESS | 1592 | __startTimestamp1467527958710__endTimestamp 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | ------- Summary: start ------- 23:39:18 INFO - PROCESS | 1592 | Number of tests: 14 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:3.31 23:39:18 INFO - PROCESS | 1592 | Values: 112.0 104.0 111.0 114.0 116.0 111.0 109.0 110.0 111.0 111.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:21.70 (13.9%) stddev-sans-first:23.01 23:39:18 INFO - PROCESS | 1592 | Values: 151.0 125.0 153.0 179.0 126.0 165.0 159.0 125.0 178.0 128.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 23:39:18 INFO - PROCESS | 1592 | Values: 163.0 161.0 163.0 162.0 163.0 162.0 163.0 163.0 161.0 161.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:40.37 (53.5%) stddev-sans-first:42.29 23:39:18 INFO - PROCESS | 1592 | Values: 77.0 75.0 77.0 175.0 75.0 74.0 76.0 75.0 168.0 78.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.00 stddev:30.07 (35.4%) stddev-sans-first:31.19 23:39:18 INFO - PROCESS | 1592 | Values: 86.0 84.0 149.0 85.0 86.0 85.0 138.0 86.0 85.0 154.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:39:18 INFO - PROCESS | 1592 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 23:39:18 INFO - PROCESS | 1592 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 149.0 148.0 146.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 23:39:18 INFO - PROCESS | 1592 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 94.0 96.0 96.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:53.50 stddev:4.16 (7.8%) stddev-sans-first:4.20 23:39:18 INFO - PROCESS | 1592 | Values: 51.0 65.0 53.0 53.0 52.0 58.0 53.0 56.0 52.0 54.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:2.72 (4.5%) stddev-sans-first:2.83 23:39:18 INFO - PROCESS | 1592 | Values: 59.0 60.0 68.0 59.0 60.0 59.0 59.0 61.0 60.0 60.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.50 stddev:10.18 (13.0%) stddev-sans-first:10.57 23:39:18 INFO - PROCESS | 1592 | Values: 76.0 76.0 83.0 82.0 81.0 77.0 78.0 77.0 110.0 79.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.00 stddev:3.31 (2.7%) stddev-sans-first:3.50 23:39:18 INFO - PROCESS | 1592 | Values: 121.0 118.0 119.0 116.0 126.0 125.0 123.0 123.0 125.0 123.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:156.00 stddev:4.98 (3.2%) stddev-sans-first:5.26 23:39:18 INFO - PROCESS | 1592 | Values: 156.0 156.0 171.0 154.0 156.0 156.0 156.0 154.0 157.0 155.0 23:39:18 INFO - PROCESS | 1592 | 23:39:18 INFO - PROCESS | 1592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 23:39:18 INFO - PROCESS | 1592 | Values: 64.0 63.0 64.0 63.0 63.0 62.0 63.0 65.0 65.0 63.0 23:39:18 INFO - PROCESS | 1592 | -------- Summary: end -------- 23:39:18 INFO - PROCESS | 1592 | 23:39:19 INFO - TEST-INFO | 1592: exit 0 23:39:19 INFO - TEST-OK | kraken | took 60921ms 23:39:19 INFO - SUITE-END | took 1170s 23:39:19 INFO - Completed test suite (00:19:31) 23:39:19 INFO - javascript benchmark 23:39:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7582.255861953309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.026492184805, 3327.800331980083, 3372.915677108072, 3380.6450322716114, 3381.0, 5537.003339398907, 5552.211781910795, 5571.86070348241, 5610.775568977236, 5618.353889302732, 5589.972050139754, 5640.830775076754, 5645.322561292651, 5646.830595082144, 5659.094544872811, 5117.027764724699, 5204.661696989683, 5207.765650545715, 5225.477452254782, 5251.76367063483, 5036.169032109698, 5103.744812759366, 5260.894782104356, 5262.631615786897, 5273.657212281209, 5154.664946778466, 5159.793608255665, 5161.509656582619, 5178.404483484391, 5187.896242075156, 5191.4548972357925, 5237.607179461536, 5238.214267859814, 5255.816046438356, 5266.34170728659, 4956.3804524434445, 5007.424146223195, 5067.822626208102, 5132.127538318495, 5139.408967968657, 5531.557475401958, 5536.086545719952, 5552.472515111099, 5591.776328946838, 5604.775808967636, 6044.153818465418, 6044.818655440344, 6062.787802426894, 6064.151018857364, 6078.604890682136, 5876.265466816648, 5992.79025234119, 6039.245094363205, 6054.334023257438, 6108.053251745942, 5707.058335374658, 5720.427957204288, 5723.599348045638, 5725.885482290331, 5731.99690054243, 6190.288116866528, 6232.594881332699, 6243.125962365272, 6252.124702541648, 6254.124422580842, 5933.258342707161, 5944.197533332945, 5944.851378715567, 5976.462118409277, 6044.818655440344, 6112.113743507167, 6143.907841382383, 6144.815655530341, 6149.046897730859, 6164.0, 5885.0, 6110.663913484801, 6116.082587611894, 6123.203983482208, 6123.510119190454, 6005.309389420273, 6027.517798576104, 6077.4834139098675, 6127.816165515042, 6133.202683651097, 4625.537446255415, 4636.397268355092, 4644.256918893028, 4646.558576935186, 4651.325557794168, 4050.0, 4082.3672330788777, 4165.312723400665, 4168.520620128724, 4187.560306167869, 5695.914561281584, 5779.682117483495, 5790.0, 5810.738516766755, 5873.765049398062, 6118.204633397719, 6120.14317995481, 6123.050927106306, 6129.11127886454, 6142.6314421134875, 5711.029125048752, 5821.7380217890295, 5868.09044598088, 5873.588848780544, 5880.705964701748, 5043.84868453947, 5055.69665820052, 5065.544101030851, 5092.363454568179, 5095.770690318945, 6351.142595749515, 6382.808515744535, 6385.936140638627, 6413.6793160341795, 6421.101045853584, 5898.94101058984, 6123.203983482119, 6129.417705317987, 6156.107364432132, 6182.165407669907, 6392.744290228525, 6402.87194256103, 6412.679366031586, 6413.134226879311, 6421.486281097407, 6047.425494578008, 6100.6949652516305, 6101.664408457577, 6107.480864126599, 6107.938920610737, 5933.436323549256, 6012.398760123952, 6056.152138700673, 6088.26940767093, 6199.783007594712, 5941.643501389931, 5974.731137098754, 5977.910331344946, 5979.730912108878, 5989.880202396015, 5894.115882617642, 5898.734556945034, 5948.762049518144, 5961.433663801932, 5966.224390829338, 5736.799212027559, 5762.049261871744, 5766.855828604151, 5773.076307790733, 5857.0, 5925.259342582177, 5965.105234214902, 5965.701714914324, 5965.850853728692, 5983.042713165873, 5665.801696940587, 5859.765609375748, 5870.970645146747, 5875.823725288248, 5890.793822216202], "value": 5604.4208392331275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6138917619783, 643.8808820368231, 655.1450357283743, 666.4068978609038, 679.6363945289271, 40493.797531012344, 45104.3234351485, 45123.999999999956, 45142.77428612852, 45426.7728661357, 46880.76559617206, 47322.52677473233, 47421.288680669815, 47453.52546474534, 47572.0, 9028.954855225747, 9102.908970910305, 9111.40775849571, 9175.036621154783, 9179.908200918006, 9017.864732029026, 9084.77288067797, 9145.634174633007, 9173.908260917406, 9182.127697868726, 9068.319876009293, 9174.08259174084, 9177.954110229439, 9181.40320879144, 9181.632734690604, 9116.772080698003, 9181.219596334286, 9190.402623829497, 9192.264618830512, 9209.401388909699, 9005.0, 9015.504147271897, 9030.503322317336, 9034.09659034098, 9091.181793638605, 42657.146857062995, 42976.57023429757, 43002.13995720068, 43030.0, 43397.349039764114, 3553.4136867416846, 3914.902127446808, 4000.0, 4089.591040895916, 4496.7301961882395, 34528.654713452794, 34798.0, 34812.477812832825, 35045.47431788525, 36199.0, 4811.78346974387, 4819.9036019279765, 4821.204501257288, 4865.318855360252, 4885.828995985124, 394988.0, 397247.0, 399104.0, 399545.0, 402519.98740006407, 62186.0, 62313.376866231665, 62740.0, 62754.0, 62817.057744133876, 39253.0, 39970.0, 40034.79982600127, 42411.0, 42695.35956960648, 18001.459956201335, 18070.5482362942, 18221.088945552936, 18225.908870455827, 18272.177752000927, 13597.660058498617, 13643.931780341234, 13691.49393566707, 13691.520796772264, 13794.65513362154, 21054.578908421747, 21100.78899211019, 21121.78878211229, 21304.680429793567, 21490.892545537172, 7654.770356889302, 7701.767717165227, 7713.65288562016, 7780.8054798629355, 7814.765557033298, 1065.4353192807823, 1125.7241975716001, 1170.8594968603823, 1186.371223251678, 1228.8893999540085, 34171.14572135716, 34194.31611367759, 34379.0, 34577.30845383078, 35270.82364588212, 1167.8598568171874, 1191.2137988927266, 1205.421397729095, 1218.6161359171833, 1233.105998151351, 17954.461366159037, 18128.818711812713, 18150.0, 18231.63536729258, 18288.17703203359, 624271.0, 984927.0, 1015686.0, 1166273.0, 1186791.0, 62039.37960620336, 62281.0, 62631.0, 62632.0, 63230.0, 1465.7141857337717, 1483.9035462694674, 1484.1614487814566, 1487.7024595081027, 1504.353128154882, 32621.836890815393, 32935.0, 33274.0, 33578.66421335755, 34177.65822341745, 53950.0, 54447.0, 54501.0, 54539.72730136483, 54618.0, 473426.0, 475039.0, 478320.2167978415, 478423.0, 478887.0, 30140.547891781203, 30244.0, 30461.086167415015, 30654.080377588707, 30800.383992320476, 48188.0, 48493.75753121212, 48947.265791012454, 50065.0, 50582.49417505925, 43746.34380484359, 43952.78023609862, 46533.76733116313, 48947.755261223465, 49578.25632615586, 45154.322685159095, 45308.773456132505, 45742.313865291384, 45849.0, 46970.76514617405, 44960.0, 45378.77310613426, 45460.0, 45897.54102458933, 45942.0, 37739.245215095, 39231.60768392394, 39306.803465982484, 39811.80094099627, 40189.79905100456, 29909.0, 30553.23616909595, 31037.534436983013, 31086.37827243488, 31093.22266943254], "value": 21691.17335930601, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.23963906412195, 414.69105516390283, 416.2819136988695, 419.75024860208174, 437.5121739260723, 19562.90218548907, 19785.307514236985, 20514.076866541003, 21687.566248675015, 21802.345929622097, 13525.256110913895, 17327.566810829736, 19323.613527729438, 20196.0, 20228.39314820554, 5400.189971504266, 5566.443355664442, 5578.079616863212, 5590.720463976785, 5601.60788744788, 5426.511613954744, 5497.890042199154, 6037.667928263966, 6038.5471089668235, 6039.124326972608, 5932.169496270526, 5984.401559844025, 5984.850378740544, 5990.221271234734, 6005.1892994445625, 5761.0, 5990.251218597676, 6005.069214271773, 6007.038873780218, 6024.759009639631, 5192.273081768555, 5406.297181366436, 5408.2698835657075, 5420.186971954238, 5433.239346491455, 14488.420463181461, 14841.480548180869, 14916.477923272634, 14989.850101498954, 18422.539436514195, 2329.138218859033, 2428.6842710447704, 2506.260653107338, 2599.1163004578534, 2826.844523551204, 11019.559217631286, 11024.559017639365, 11096.611618593392, 11144.498497567629, 14761.819054475616, 2039.4901274681329, 2051.138521820839, 2084.718562993992, 2096.8846713430753, 2113.7569179544244, 90240.54879725626, 90465.0, 92235.53882230613, 92284.0, 92593.53703231509, 11884.168108232341, 11888.405579720978, 11909.0, 12057.879421205851, 12165.93917030427, 13075.738485230433, 17006.744898826528, 17016.31934722622, 17024.063676497663, 17024.233909474104, 8042.276195142465, 8135.30849877767, 8388.916110838814, 8430.0, 8540.487570745776, 8207.589620518951, 8213.34293256538, 8335.583220838933, 8521.147885211552, 8678.262347700516, 4318.632916202158, 4349.173657005159, 4356.586124318184, 4388.517263101056, 4402.25161722508, 2033.542452948075, 2072.4611600983553, 2096.874187548752, 2108.3780284816016, 2133.8826364549786, 486.76878482721133, 1037.870266216723, 1136.959681891077, 1144.1933436927113, 1187.7980743273665, 12273.570425035081, 12827.679308017188, 12928.095033347576, 12998.870011299956, 13087.280199588924, 502.6607040247818, 506.88341681412743, 523.2883278740909, 524.1865429004026, 525.6688286379556, 6625.734970601218, 6745.291744366869, 6801.65991700413, 6909.965450172717, 6934.514583979073, 566262.0, 580047.1995280078, 586844.0, 614989.0, 662086.0, 106127.46936265424, 106883.46558267159, 107608.0, 108095.45952270189, 109137.0, 495.63946965579714, 498.48157915767194, 501.7340809371039, 505.4137200847, 508.10319785578486, 11311.208215424842, 11755.177137600627, 11790.587329443428, 11887.762244754884, 11956.641300760992, 41285.0, 43197.78401107974, 43652.34521482244, 43666.126677466906, 44316.33525497185, 56919.0, 59706.40293597009, 65625.34374656383, 65770.67114664396, 65895.67052164709, 8803.427777194462, 9000.459972401677, 9177.449353038839, 9303.255739540957, 9344.6917431561, 13565.389557470135, 14171.787423188454, 14216.0, 14252.786208206679, 14607.196604186447, 12640.936795315965, 12654.810177847523, 12761.93619031899, 12867.742645147231, 12891.226526408445, 12355.0, 12579.433925473193, 12672.176308539916, 12744.872551274368, 12860.549880754128, 12850.742985140057, 12860.2926839021, 12961.481540738265, 13055.412506437044, 13187.274699891597, 8923.196912277666, 8943.910560894308, 8951.41815781998, 8963.641454341754, 9010.504422256576, 9587.856182157413, 13087.345632718516, 13102.475900963855, 13167.60497185086, 13268.336583170996], "value": 8899.612481901268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.5818399940015, 1564.7339952208126, 1742.8431441170292, 1883.8304552590264, 1904.6857268550698, 8180.100188979208, 8703.825923481527, 8703.956480217597, 9265.814683706321, 9274.072592740731, 8706.956465217681, 8906.86639700405, 9091.72724818255, 9106.499142547158, 9116.8632470513, 2298.310506847943, 2325.011869955271, 2345.8944347504403, 2349.8472599281076, 2352.517733864562, 2362.6337917622795, 2366.4912043910554, 2400.603900356448, 2406.109739396426, 2414.082648593541, 2354.211339201361, 2355.34050465869, 2355.9764402355927, 2372.0037584214583, 2389.3668177932773, 2244.259394399844, 2247.584196923566, 2256.9435764105865, 2264.1056782570877, 2282.589133955887, 2250.561140577588, 2252.1329288223988, 2253.6506841439605, 2257.9096836126537, 2262.9434264143365, 8862.734117976472, 9044.54777261141, 9067.54662266884, 9077.909220907772, 9082.954585227099, 5379.354477462691, 5496.258005169291, 5521.585881058937, 5522.337319521643, 5556.0, 3453.4992426098324, 3531.876384326562, 3550.6981906537976, 3638.6543278388513, 3662.34077865984, 1115.3865374044244, 1122.0518661730905, 1136.8294755786615, 1178.917475776696, 1181.314837394318, 13072.215667060007, 13163.67090822737, 13166.539171128965, 13185.208887466782, 13247.602571922858, 4803.519648035169, 4824.589909857631, 4912.189488734391, 4912.312276281324, 4915.16442204826, 10951.4524273786, 11011.174161937886, 11027.2280940335, 11033.889661103447, 11122.332660040423, 5520.66875987434, 5541.889162216814, 5563.66618002913, 5598.300212473441, 5619.578531610146, 4518.615917647036, 5019.67372120811, 5135.35808023997, 5183.3261675981885, 5194.1429664105, 4225.619694227473, 4235.131797981407, 4237.618614324726, 4263.445752052276, 4301.65586753059, 1286.067600989294, 1333.9066265361332, 1334.9132306400054, 1342.4630147940902, 1349.62885206569, 1054.6625079974488, 1056.3239526702916, 1057.772578895541, 1064.4039337970762, 1066.7119877632995, 6368.0, 6596.406323430914, 6695.12963314766, 6742.764003259862, 6747.527673062838, 464.7118786352483, 467.28505386758314, 473.01612645696866, 473.8436316015707, 493.41530286609765, 4558.111168322212, 4574.245249533789, 4615.95384046162, 4623.69945953512, 4630.236011058205, 10895.400752958663, 11156.051735602403, 11172.162087843444, 11202.719932001764, 11230.550777968952, 11041.39272340029, 11127.165462590337, 11131.610393636183, 11161.441927903572, 11363.318200907972, 8683.696070637498, 8782.297416206688, 8818.691345802867, 8856.3800533962, 8863.911360886308, 6646.335366463315, 6875.0718652983205, 6931.826704332432, 6932.376086152069, 6932.792016239521, 10325.74185645365, 10676.893231067901, 10690.305130166515, 10743.785124297627, 10784.0, 11018.44907754593, 11102.777944440904, 11124.833127503256, 11165.274257173258, 11259.662210133709, 7590.127135379502, 7869.449138560246, 8049.959750201211, 8368.246857782586, 8556.229939305493, 8409.2431681149, 8496.0, 8499.660013599387, 8501.234888860032, 8539.188777066169, 7713.344365728976, 8067.798305042421, 8163.061247956323, 8164.7550573482895, 8261.463004904663, 7966.800829979297, 8149.674013039412, 8274.462159959583, 8368.748937531884, 8382.83234335322, 7021.806292930316, 7094.077769889881, 7172.605506697182, 7183.640817958976, 7220.277972202738, 5744.224529688438, 5757.251557297692, 5842.737076831638, 5865.794697185578, 5893.705314734332, 5723.8855222896145, 5834.795782147605, 5841.561882858888, 5854.443827836349, 5979.4917432018765], "value": 4792.340577301497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.8295852073963, 343.0737010072804, 343.48305799771356, 355.8683287183742, 356.95181150544676, 5775.422457754223, 5787.0, 5787.971060144699, 5798.420157984199, 5838.416158384154, 5717.828465146053, 5742.942570574293, 5758.3588677227, 5762.193292938981, 5775.768969241236, 4270.231358355495, 4505.932411013838, 4508.684392092555, 4517.887052823689, 4529.728216307016, 4480.148771733377, 4547.249703798886, 4573.131105090022, 4573.725576465423, 4578.496365399803, 4495.213337665896, 4529.841455549056, 4533.818647254106, 4544.545545445446, 4549.61328287096, 4448.955510444886, 4470.664700147502, 4500.559820857327, 4504.121696269212, 4509.1883460977015, 3958.148997965451, 3987.4249671379935, 4003.259397011562, 4009.8797036088963, 4017.2367250222364, 5357.81247656334, 5499.587530935196, 5596.4403559644115, 5625.971870140623, 5633.718314084321, 5079.74601269935, 5158.819441319536, 5171.405288391846, 5217.426083130853, 5239.087732977436, 6019.789307374221, 6032.819015429544, 6036.3360030396625, 6050.364711705296, 6136.386361363872, 4387.802548885308, 4465.419495465601, 4511.1654343946475, 4518.728876267434, 4522.276435770261, 6147.600405973598, 6298.937010629927, 6326.905096423558, 6328.493720502394, 6396.6162030277865, 4457.554244575581, 4467.329900514948, 4491.281394976788, 4493.5281795411665, 4505.707129036602, 4515.458145022552, 4529.773511324486, 4531.478879928851, 4537.546245375436, 4548.56788605082, 5077.949220507748, 5115.311947057462, 5144.43411224765, 5180.974095129575, 5200.323957885451, 6023.427774361428, 6094.329623741385, 6103.1455596216565, 6106.694665266719, 6111.266648002268, 1591.610055536401, 1595.6250281183914, 1607.3088571913956, 1631.5023917705214, 1631.7470792027254, 1020.8570800087845, 1047.7223535763028, 1061.4215252687304, 1065.8667666541683, 1073.3774410841693, 5920.526357891358, 5927.911081333784, 5934.673592952429, 5952.434518720715, 5969.432903874125, 6102.9694851525455, 6173.876522469525, 6200.906986395207, 6230.875382492415, 6251.531135164881, 5739.397363276796, 5802.3037235531165, 5865.912011319833, 5890.175375447441, 5998.310194327621, 3299.0762586475344, 3321.684439978198, 3323.4848598467274, 3333.5499707539657, 3346.7657263991773, 6194.287656919422, 6409.711562979677, 6450.290468048511, 6597.868042639217, 6613.966930165415, 6431.614103153732, 6441.64570948593, 6461.8061458156335, 6467.935320646828, 6481.0, 6305.842353941188, 6518.73925042993, 6559.934400656028, 6583.473322134314, 6610.182199894971, 6336.398042185985, 6349.111124442489, 6372.0, 6379.904301435575, 6393.1688880445245, 5923.733431995657, 6261.966775481995, 6277.5605707600025, 6292.182016337847, 6301.306856245717, 6470.6735119301375, 6556.475481961336, 6591.307912669101, 6597.977313516412, 6662.966685166543, 4466.4640243171025, 4511.954880451153, 4522.660800440046, 4522.909541809211, 4538.160440318552, 6201.108661857997, 6266.310705822265, 6310.968445157929, 6329.430351268408, 6455.4512866405, 6123.632582045091, 6158.353372895782, 6226.688665566794, 6242.781502647385, 6252.9370007099815, 5905.291365036223, 6121.969390153021, 6133.141360209485, 6139.723712432862, 6169.722362493609, 6050.878982420415, 6060.878782424415, 6070.514358851193, 6091.0, 6107.755689772359, 6124.877502449837, 6175.536834737323, 6214.751409943552, 6230.376962303733, 6242.65665388408, 5861.501772349398, 6077.756889724538, 6090.665013424305, 6101.993171126892, 6116.816495505142], "value": 4671.72864840305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9491835571512, 746.3059354800034, 795.2921899509438, 888.4580405952368, 914.6021480655913, 13974.0, 14747.41010359587, 14931.701365972674, 15271.847281527182, 15469.767953480692, 15224.162671053115, 15266.0, 15311.77032344513, 15381.769273460879, 15423.845761542381, 840.8906842110517, 845.5476320168711, 861.4357595774777, 866.7096522664915, 869.9782505437352, 852.3820230333021, 858.6908712863365, 860.5482121885997, 860.7977125375531, 862.3747782857441, 880.995595022024, 881.9691310804124, 882.9249513791335, 887.0021226120614, 888.2272422992006, 873.9082396348388, 876.9473831570094, 877.4384393987852, 877.6094637886143, 878.8066625342415, 654.4731491149622, 655.5673255651247, 660.0824853453655, 660.3066779881106, 662.0069895157264, 15927.124008179546, 16038.278277477542, 16067.517974460785, 16073.196340182943, 16090.0, 13033.608991730263, 14336.928315358356, 14772.630684232872, 15055.47305844301, 16247.02517848921, 13038.024656808657, 13580.0, 13705.314734263347, 13862.098963567336, 13863.653408664763, 4814.109389762905, 4842.055799119174, 4897.975510122426, 4905.068037072945, 4923.975380123076, 79478.0, 79958.0, 80016.59991700063, 81025.59487202526, 81610.18389816085, 11478.196526243082, 11908.404579770977, 12036.39818009096, 12081.582904155664, 12142.08934329911, 23179.0, 23268.0, 23272.3018309451, 23286.767132328798, 23482.295531134092, 9321.95339023314, 9339.439633622005, 9358.298127640453, 9423.575939082757, 9596.424214547149, 4467.865964021084, 4687.296905464208, 4707.223308154116, 4856.39295088114, 4903.632227582945, 3506.8421921013614, 3633.3459977204357, 3634.545681789776, 3651.507046548682, 3651.561812582507, 638.543441439373, 657.5298661456985, 658.236445722959, 661.490652197805, 666.0608541955819, 582.525241927836, 663.2637772072995, 686.8030061219363, 724.2142275630894, 728.1553398058227, 9214.815703685888, 9407.2003879671, 9476.905230947741, 9534.475603841716, 9816.263780216512, 508.3493128795148, 685.9984422742851, 718.6263143165525, 756.5120497279224, 770.9884351734728, 4726.669133160645, 4809.110314591811, 4936.136176169156, 4980.526849949249, 4991.3511243538105, 72523.2747672527, 73086.269137309, 73159.0, 118029.0, 123887.0, 89911.55044224738, 91862.0, 100368.0, 101789.49105254427, 101981.0, 93248.53375733078, 93754.0624593759, 94122.0, 95860.52069739606, 100183.0, 10000.849987250343, 10048.145907597936, 10324.638637647646, 10341.37951722899, 10391.84412233802, 46308.7684561575, 49133.50866491289, 49573.504264958334, 54955.175672365745, 55130.17304740352, 73521.0, 73648.0, 81662.59168704356, 81853.59073204834, 81926.18073819423, 12562.497500099893, 12595.685107872376, 12727.172733772275, 13988.37052332668, 14400.639984000483, 15008.099514029193, 15045.699086018438, 16004.119773412574, 16035.919820400823, 16071.758923615922, 12765.234085954873, 14024.158550487004, 14213.289335533389, 14297.64255893611, 14769.778453322993, 14153.363098660791, 14163.150210987375, 14299.928500357431, 14659.853401466275, 14910.701785964004, 11725.589604363806, 12995.155314904501, 13038.087333886537, 14214.0, 14245.21651309188, 11804.080581836919, 11835.644930652094, 12288.1398302118, 12327.383630818602, 12453.315067671003, 11918.344491053076, 11974.401279936143, 12092.0, 12124.211926224767, 12240.75518489643], "value": 7844.023056444355, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 111.0, 114.0, 116.0, 111.0, 109.0, 110.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 153.0, 179.0, 126.0, 165.0, 159.0, 125.0, 178.0, 128.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 175.0, 75.0, 74.0, 76.0, 75.0, 168.0, 78.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 149.0, 85.0, 86.0, 85.0, 138.0, 86.0, 85.0, 154.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 149.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 94.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 65.0, 53.0, 53.0, 52.0, 58.0, 53.0, 56.0, 52.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 68.0, 59.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 83.0, 82.0, 81.0, 77.0, 78.0, 77.0, 110.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 119.0, 116.0, 126.0, 125.0, 123.0, 123.0, 125.0, 123.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 171.0, 154.0, 156.0, 156.0, 156.0, 154.0, 157.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 62.0, 63.0, 65.0, 65.0, 63.0], "value": 63.5, "unit": "score"}]}]} 23:39:19 INFO - Return code: 0 23:39:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:39:19 ERROR - # TBPL SUCCESS # 23:39:19 INFO - Running post-action listener: _resource_record_post_action 23:39:19 INFO - ##### 23:39:19 INFO - ##### Finished run-tests step (success) 23:39:19 INFO - ##### 23:39:19 INFO - Running post-run listener: _resource_record_post_run 23:39:20 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505921536; Read time: 12; Write time: 449452 23:39:20 INFO - TinderboxPrint: CPU usage
13.3% 23:39:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:39:20 INFO - TinderboxPrint: I/O write bytes / time
505,921,536 / 449,452 23:39:20 INFO - TinderboxPrint: CPU idle
8,213.4 (86.6%) 23:39:20 INFO - TinderboxPrint: CPU user
1,211.9 (12.8%) 23:39:20 INFO - TinderboxPrint: Swap in / out
0 / 0 23:39:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252932096; Read time: 0; Write time: 276636 23:39:20 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252989440; Read time: 12; Write time: 172816 23:39:20 INFO - Running post-run listener: _upload_blobber_files 23:39:20 INFO - Blob upload gear active. 23:39:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:39:20 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 23:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:39:21 INFO - (blobuploader) - INFO - Open directory for files ... 23:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:21 INFO - (blobuploader) - INFO - Done attempting. 23:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:22 INFO - (blobuploader) - INFO - Done attempting. 23:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:26 INFO - (blobuploader) - INFO - Done attempting. 23:39:26 INFO - (blobuploader) - INFO - Iteration through files over. 23:39:26 INFO - Return code: 0 23:39:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:39:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:39:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b7a041c153b76ee218b23f4bc45f7902946de81d16c3f1693ad774a08ffd54cc2eed615cbed044e93eb9c13bf6ca6af595c8dfedbb5f53663dd3f88473d80ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b04574b18f706602cbd56f1aad76f653a97ec5fadeed5f3369960e5229c9d291b954662a598347621716ada231966cfd094605cc6e51d3ae0fcf3612e7433555", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0cc36cfe63f9868d15f11e6bea6eac2b28fdc5b55137a16991cbb3dd62aaa79abf20bb1a3390a2dcdacbd61632af91d485263dd22dacd440f606e11ea06d522"} 23:39:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:39:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:39:26 INFO - Contents: 23:39:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b7a041c153b76ee218b23f4bc45f7902946de81d16c3f1693ad774a08ffd54cc2eed615cbed044e93eb9c13bf6ca6af595c8dfedbb5f53663dd3f88473d80ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b04574b18f706602cbd56f1aad76f653a97ec5fadeed5f3369960e5229c9d291b954662a598347621716ada231966cfd094605cc6e51d3ae0fcf3612e7433555", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0cc36cfe63f9868d15f11e6bea6eac2b28fdc5b55137a16991cbb3dd62aaa79abf20bb1a3390a2dcdacbd61632af91d485263dd22dacd440f606e11ea06d522"} 23:39:26 INFO - Running post-run listener: copy_logs_to_upload_dir 23:39:26 INFO - Copying logs to upload dir... 23:39:26 INFO - mkdir: /builds/slave/test/build/upload/logs 23:39:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.060961 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-02 23:39:25.055700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:39:25.059818) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b7a041c153b76ee218b23f4bc45f7902946de81d16c3f1693ad774a08ffd54cc2eed615cbed044e93eb9c13bf6ca6af595c8dfedbb5f53663dd3f88473d80ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b04574b18f706602cbd56f1aad76f653a97ec5fadeed5f3369960e5229c9d291b954662a598347621716ada231966cfd094605cc6e51d3ae0fcf3612e7433555", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0cc36cfe63f9868d15f11e6bea6eac2b28fdc5b55137a16991cbb3dd62aaa79abf20bb1a3390a2dcdacbd61632af91d485263dd22dacd440f606e11ea06d522"} build_url:https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b7a041c153b76ee218b23f4bc45f7902946de81d16c3f1693ad774a08ffd54cc2eed615cbed044e93eb9c13bf6ca6af595c8dfedbb5f53663dd3f88473d80ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b04574b18f706602cbd56f1aad76f653a97ec5fadeed5f3369960e5229c9d291b954662a598347621716ada231966cfd094605cc6e51d3ae0fcf3612e7433555", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0cc36cfe63f9868d15f11e6bea6eac2b28fdc5b55137a16991cbb3dd62aaa79abf20bb1a3390a2dcdacbd61632af91d485263dd22dacd440f606e11ea06d522"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:39:25.085950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:39:25.086516) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467526735.91461-865509911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:39:25.170059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:39:25.170609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:39:25.171162) ========= ========= Total master_lag: 0.18 =========