builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1467101917.74 results: success (0) buildid: 20160627130921 builduid: a6b74d1bbac54478809dc3da76fbdb0f revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.737628) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.738061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.738340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.679178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.679455) ========= 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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:18:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-06-28 01:18:39 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141400 ========= master_lag: 0.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.318950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.319232) ========= 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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014968 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.554388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.558990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20f82876561686c4f8a619a0e1baa9f58261e0f --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 f20f82876561686c4f8a619a0e1baa9f58261e0f --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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:18:39,921 truncating revision to first 12 chars 2016-06-28 01:18:39,921 Setting DEBUG logging. 2016-06-28 01:18:39,921 attempt 1/10 2016-06-28 01:18:39,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f20f82876561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:18:40,228 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637823 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.295445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.295800) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.302835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.303140) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.397261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-28 01:18:40.397626) ========= /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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:18:40 INFO - MultiFileLogger online at 20160628 01:18:40 in /builds/slave/test 01:18:40 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 01:18:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:18:40 INFO - {'append_to_log': False, 01:18:40 INFO - 'base_work_dir': '/builds/slave/test', 01:18:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:18:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:18:40 INFO - 'branch': 'Mozilla-Aurora', 01:18:40 INFO - 'buildbot_json_path': 'buildprops.json', 01:18:40 INFO - 'config_files': ('talos/linux_config.py',), 01:18:40 INFO - 'default_actions': ('clobber', 01:18:40 INFO - 'read-buildbot-config', 01:18:40 INFO - 'download-and-extract', 01:18:40 INFO - 'populate-webroot', 01:18:40 INFO - 'create-virtualenv', 01:18:40 INFO - 'install', 01:18:40 INFO - 'run-tests'), 01:18:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:18:40 INFO - 'download_minidump_stackwalk': True, 01:18:40 INFO - 'download_symbols': 'ondemand', 01:18:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:18:40 INFO - 'tooltool.py': '/tools/tooltool.py', 01:18:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:18:40 INFO - '/tools/misc-python/virtualenv.py')}, 01:18:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:18:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:18:40 INFO - 'installer_path': 'installer.exe', 01:18:40 INFO - 'log_level': 'info', 01:18:40 INFO - 'log_name': 'talos', 01:18:40 INFO - 'log_to_console': True, 01:18:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:18:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:18:40 INFO - 'opt_config_files': (), 01:18:40 INFO - 'pip_index': False, 01:18:40 INFO - 'sps_profile': False, 01:18:40 INFO - 'sps_profile_interval': 0, 01:18:40 INFO - 'suite': 'dromaeojs-e10s', 01:18:40 INFO - 'system_bits': '32', 01:18:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:18:40 INFO - 'title': 'talos-linux64-ix-021', 01:18:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:18:40 INFO - 'use_talos_json': True, 01:18:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:18:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:18:40 INFO - 'work_dir': 'build'} 01:18:40 INFO - ##### 01:18:40 INFO - ##### Running clobber step. 01:18:40 INFO - ##### 01:18:40 INFO - Running pre-action listener: _resource_record_pre_action 01:18:40 INFO - Running main action method: clobber 01:18:40 INFO - rmtree: /builds/slave/test/build 01:18:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:18:41 INFO - Running post-action listener: _resource_record_post_action 01:18:41 INFO - ##### 01:18:41 INFO - ##### Finished clobber step (success) 01:18:41 INFO - ##### 01:18:41 INFO - ##### 01:18:41 INFO - ##### Running read-buildbot-config step. 01:18:41 INFO - ##### 01:18:41 INFO - Running pre-action listener: _resource_record_pre_action 01:18:41 INFO - Running main action method: read_buildbot_config 01:18:41 INFO - Using buildbot properties: 01:18:41 INFO - { 01:18:41 INFO - "project": "", 01:18:41 INFO - "product": "firefox", 01:18:41 INFO - "script_repo_revision": "production", 01:18:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:18:41 INFO - "repository": "", 01:18:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 01:18:41 INFO - "buildid": "20160627130921", 01:18:41 INFO - "pgo_build": "True", 01:18:41 INFO - "basedir": "/builds/slave/test", 01:18:41 INFO - "buildnumber": 374, 01:18:41 INFO - "slavename": "talos-linux64-ix-021", 01:18:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:18:41 INFO - "platform": "ubuntu64_hw", 01:18:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:18:41 INFO - "branch": "mozilla-aurora", 01:18:41 INFO - "repo_path": "releases/mozilla-aurora", 01:18:41 INFO - "revision": "f20f82876561686c4f8a619a0e1baa9f58261e0f", 01:18:41 INFO - "stage_platform": "linux64-pgo", 01:18:41 INFO - "builduid": "a6b74d1bbac54478809dc3da76fbdb0f", 01:18:41 INFO - "slavebuilddir": "test" 01:18:41 INFO - } 01:18:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:18:41 INFO - Running post-action listener: _resource_record_post_action 01:18:41 INFO - ##### 01:18:41 INFO - ##### Finished read-buildbot-config step (success) 01:18:41 INFO - ##### 01:18:41 INFO - ##### 01:18:41 INFO - ##### Running download-and-extract step. 01:18:41 INFO - ##### 01:18:41 INFO - Running pre-action listener: _resource_record_pre_action 01:18:41 INFO - Running main action method: download_and_extract 01:18:41 INFO - mkdir: /builds/slave/test/build/tests 01:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:41 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:46 INFO - Downloaded 1361 bytes. 01:18:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:46 INFO - Using the following test package requirements: 01:18:46 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:46 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:18:46 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:18:46 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'jsshell-linux-x86_64.zip'], 01:18:46 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:18:46 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:46 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:18:46 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:18:46 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:18:46 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:18:46 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:46 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:18:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:50 INFO - Downloaded 24525033 bytes. 01:18:50 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'] 01:18:50 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 01:18:51 INFO - Return code: 0 01:18:51 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 01:18:51 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')]} 01:18:51 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:55 INFO - Downloaded 24525033 bytes. 01:18:55 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'] 01:18:55 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 01:18:56 INFO - Return code: 0 01:18:56 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')]} 01:18:56 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:58 INFO - Downloaded 10833369 bytes. 01:18:58 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'] 01:18:58 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 01:18:58 INFO - Return code: 0 01: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')]} 01:18:58 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:19:04 INFO - Downloaded 63614591 bytes. 01:19:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:19:04 INFO - mkdir: /builds/slave/test/properties 01:19:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:04 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:04 INFO - Contents: 01:19:04 INFO - build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:19:05 INFO - Running post-action listener: _resource_record_post_action 01:19:05 INFO - Running post-action listener: set_extra_try_arguments 01:19:05 INFO - ##### 01:19:05 INFO - ##### Finished download-and-extract step (success) 01:19:05 INFO - ##### 01:19:05 INFO - ##### 01:19:05 INFO - ##### Running populate-webroot step. 01:19:05 INFO - ##### 01:19:05 INFO - Running pre-action listener: _resource_record_pre_action 01:19:05 INFO - Running main action method: populate_webroot 01:19:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:05 INFO - '--tppagecycles', 01:19:05 INFO - '7'], 01:19:05 INFO - 'tests': ['tsvgm']}}, 01:19:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['damp', 'tps']}, 01:19:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'tests': ['damp', 'tps']}, 01:19:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['dromaeo_dom']}, 01:19:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['a11yr', 01:19:05 INFO - 'ts_paint', 01:19:05 INFO - 'tpaint', 01:19:05 INFO - 'sessionrestore', 01:19:05 INFO - 'sessionrestore_no_auto_restore', 01:19:05 INFO - 'tabpaint']}, 01:19:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['tsvgx', 01:19:05 INFO - 'tsvgr_opacity', 01:19:05 INFO - 'tart', 01:19:05 INFO - 'tscrollx', 01:19:05 INFO - 'cart']}, 01:19:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:05 INFO - 'tsvgr_opacity', 01:19:05 INFO - 'tart', 01:19:05 INFO - 'tscrollx', 01:19:05 INFO - 'cart']}, 01:19:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'talos_options': ['--disable-e10s'], 01:19:05 INFO - 'tests': ['tp5o']}, 01:19:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'tests': ['tp5o']}, 01:19:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'talos_options': ['--disable-e10s', 01:19:05 INFO - '--xperf_path', 01:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:05 INFO - 'tests': ['tp5n']}, 01:19:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:05 INFO - 'talos_options': ['--xperf_path', 01:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:05 INFO - 'tests': ['tp5n']}}, 01:19:05 INFO - 'talos.zip': {'path': '', 01:19:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:05 INFO - Running post-action listener: _resource_record_post_action 01:19:05 INFO - ##### 01:19:05 INFO - ##### Finished populate-webroot step (success) 01:19:05 INFO - ##### 01:19:05 INFO - ##### 01:19:05 INFO - ##### Running create-virtualenv step. 01:19:05 INFO - ##### 01:19:05 INFO - Running pre-action listener: _resource_record_pre_action 01:19:05 INFO - Running main action method: create_virtualenv 01:19:05 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:05 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 01:19:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:05 INFO - Using real prefix '/usr' 01:19:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:06 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:08 INFO - Installing pip.................done. 01:19:08 INFO - Return code: 0 01:19:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:08 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')]} 01:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 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')]} 01:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:08 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 01:19:08 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 01:19:08 INFO - Using env: {'DISPLAY': ':0', 01:19:08 INFO - 'HOME': '/home/cltbld', 01:19:08 INFO - 'LANG': 'en_US.UTF-8', 01:19:08 INFO - 'LANGUAGE': 'en_US:en', 01:19:08 INFO - 'LOGNAME': 'cltbld', 01:19:08 INFO - 'MAIL': '/var/mail/cltbld', 01:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:08 INFO - 'MOZ_NO_REMOTE': '1', 01:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:08 INFO - 'NO_EM_RESTART': '1', 01:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:08 INFO - 'PWD': '/builds/slave/test', 01:19:08 INFO - 'SHELL': '/bin/bash', 01:19:08 INFO - 'SHLVL': '1', 01:19:08 INFO - 'TERM': 'linux', 01:19:08 INFO - 'TMOUT': '86400', 01:19:08 INFO - 'USER': 'cltbld', 01:19:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:08 INFO - '_': '/tools/buildbot/bin/python'} 01:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:08 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 01:19:08 INFO - Cleaning up... 01:19:08 INFO - Return code: 0 01:19:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:08 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')]} 01:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 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')]} 01:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:08 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 01:19:08 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 01:19:08 INFO - Using env: {'DISPLAY': ':0', 01:19:08 INFO - 'HOME': '/home/cltbld', 01:19:08 INFO - 'LANG': 'en_US.UTF-8', 01:19:08 INFO - 'LANGUAGE': 'en_US:en', 01:19:08 INFO - 'LOGNAME': 'cltbld', 01:19:08 INFO - 'MAIL': '/var/mail/cltbld', 01:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:08 INFO - 'MOZ_NO_REMOTE': '1', 01:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:08 INFO - 'NO_EM_RESTART': '1', 01:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:08 INFO - 'PWD': '/builds/slave/test', 01:19:08 INFO - 'SHELL': '/bin/bash', 01:19:08 INFO - 'SHLVL': '1', 01:19:08 INFO - 'TERM': 'linux', 01:19:08 INFO - 'TMOUT': '86400', 01:19:08 INFO - 'USER': 'cltbld', 01:19:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:08 INFO - '_': '/tools/buildbot/bin/python'} 01:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:08 INFO - Downloading/unpacking psutil>=3.1.1 01:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:10 INFO - Installing collected packages: psutil 01:19:10 INFO - Running setup.py install for psutil 01:19:10 INFO - building 'psutil._psutil_linux' extension 01:19:10 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 01:19:11 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 01:19:11 INFO - building 'psutil._psutil_posix' extension 01:19:11 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 01:19:11 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 01:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:11 INFO - Successfully installed psutil 01:19:11 INFO - Cleaning up... 01:19:11 INFO - Return code: 0 01:19:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:11 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:11 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 01:19:11 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 01:19:11 INFO - Using env: {'DISPLAY': ':0', 01:19:11 INFO - 'HOME': '/home/cltbld', 01:19:11 INFO - 'LANG': 'en_US.UTF-8', 01:19:11 INFO - 'LANGUAGE': 'en_US:en', 01:19:11 INFO - 'LOGNAME': 'cltbld', 01:19:11 INFO - 'MAIL': '/var/mail/cltbld', 01:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:11 INFO - 'MOZ_NO_REMOTE': '1', 01:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:11 INFO - 'NO_EM_RESTART': '1', 01:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:11 INFO - 'PWD': '/builds/slave/test', 01:19:11 INFO - 'SHELL': '/bin/bash', 01:19:11 INFO - 'SHLVL': '1', 01:19:11 INFO - 'TERM': 'linux', 01:19:11 INFO - 'TMOUT': '86400', 01:19:11 INFO - 'USER': 'cltbld', 01:19:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:11 INFO - '_': '/tools/buildbot/bin/python'} 01:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:13 INFO - Installing collected packages: mozsystemmonitor 01:19:13 INFO - Running setup.py install for mozsystemmonitor 01:19:13 INFO - Successfully installed mozsystemmonitor 01:19:13 INFO - Cleaning up... 01:19:13 INFO - Return code: 0 01:19:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:13 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:13 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 01:19:13 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 01:19:13 INFO - Using env: {'DISPLAY': ':0', 01:19:13 INFO - 'HOME': '/home/cltbld', 01:19:13 INFO - 'LANG': 'en_US.UTF-8', 01:19:13 INFO - 'LANGUAGE': 'en_US:en', 01:19:13 INFO - 'LOGNAME': 'cltbld', 01:19:13 INFO - 'MAIL': '/var/mail/cltbld', 01:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:13 INFO - 'MOZ_NO_REMOTE': '1', 01:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:13 INFO - 'NO_EM_RESTART': '1', 01:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:13 INFO - 'PWD': '/builds/slave/test', 01:19:13 INFO - 'SHELL': '/bin/bash', 01:19:13 INFO - 'SHLVL': '1', 01:19:13 INFO - 'TERM': 'linux', 01:19:13 INFO - 'TMOUT': '86400', 01:19:13 INFO - 'USER': 'cltbld', 01:19:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:13 INFO - '_': '/tools/buildbot/bin/python'} 01:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:13 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:15 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 01:19:15 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 01:19:15 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 01:19:15 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 01:19:15 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 01:19:15 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 01:19:16 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:16 INFO - warning: no files found matching '*.txt' 01:19:16 INFO - no previously-included directories found matching 'build' 01:19:16 INFO - no previously-included directories found matching 'dist' 01:19:16 INFO - no previously-included directories found matching '.git*' 01:19:16 INFO - Installing collected packages: jsonschema, functools32 01:19:16 INFO - Running setup.py install for functools32 01:19:16 INFO - warning: no files found matching '*.txt' 01:19:16 INFO - no previously-included directories found matching 'build' 01:19:16 INFO - no previously-included directories found matching 'dist' 01:19:16 INFO - no previously-included directories found matching '.git*' 01:19:16 INFO - Successfully installed jsonschema functools32 01:19:16 INFO - Cleaning up... 01:19:16 INFO - Return code: 0 01:19:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:16 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 01:19:16 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 01:19:16 INFO - Using env: {'DISPLAY': ':0', 01:19:16 INFO - 'HOME': '/home/cltbld', 01:19:16 INFO - 'LANG': 'en_US.UTF-8', 01:19:16 INFO - 'LANGUAGE': 'en_US:en', 01:19:16 INFO - 'LOGNAME': 'cltbld', 01:19:16 INFO - 'MAIL': '/var/mail/cltbld', 01:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:16 INFO - 'MOZ_NO_REMOTE': '1', 01:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:16 INFO - 'NO_EM_RESTART': '1', 01:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:16 INFO - 'PWD': '/builds/slave/test', 01:19:16 INFO - 'SHELL': '/bin/bash', 01:19:16 INFO - 'SHLVL': '1', 01:19:16 INFO - 'TERM': 'linux', 01:19:16 INFO - 'TMOUT': '86400', 01:19:16 INFO - 'USER': 'cltbld', 01:19:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:16 INFO - '_': '/tools/buildbot/bin/python'} 01:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:16 INFO - Downloading/unpacking blobuploader==1.2.4 01: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 01: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 01: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 01: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 01: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 01: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 01:19:18 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:18 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 01:19:18 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 01:19:18 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 01:19:18 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 01:19:18 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 01:19:18 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 01:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01: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 01: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 01: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 01: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 01: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 01: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 01:19:19 INFO - Downloading docopt-0.6.1.tar.gz 01:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:19 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:19 INFO - Running setup.py install for blobuploader 01:19:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:19 INFO - Running setup.py install for requests 01:19:19 INFO - Running setup.py install for docopt 01:19:19 INFO - Successfully installed blobuploader requests docopt 01:19:19 INFO - Cleaning up... 01:19:19 INFO - Return code: 0 01:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:19 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')]} 01:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:19 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')]} 01:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:19 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:19 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 01:19:19 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 01:19:19 INFO - Using env: {'DISPLAY': ':0', 01:19:19 INFO - 'HOME': '/home/cltbld', 01:19:19 INFO - 'LANG': 'en_US.UTF-8', 01:19:19 INFO - 'LANGUAGE': 'en_US:en', 01:19:19 INFO - 'LOGNAME': 'cltbld', 01:19:19 INFO - 'MAIL': '/var/mail/cltbld', 01:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:19 INFO - 'MOZ_NO_REMOTE': '1', 01:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:19 INFO - 'NO_EM_RESTART': '1', 01:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:19 INFO - 'PWD': '/builds/slave/test', 01:19:19 INFO - 'SHELL': '/bin/bash', 01:19:19 INFO - 'SHLVL': '1', 01:19:19 INFO - 'TERM': 'linux', 01:19:19 INFO - 'TMOUT': '86400', 01:19:19 INFO - 'USER': 'cltbld', 01:19:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:19 INFO - '_': '/tools/buildbot/bin/python'} 01:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:20 INFO - Running setup.py (path:/tmp/pip-yKz45K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:20 INFO - Running setup.py (path:/tmp/pip-s9R3sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:20 INFO - Running setup.py (path:/tmp/pip-R7qtJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:20 INFO - Running setup.py (path:/tmp/pip-6gCp8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:20 INFO - Running setup.py (path:/tmp/pip-lmfq5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:20 INFO - Running setup.py (path:/tmp/pip-qG_Mfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:20 INFO - Running setup.py (path:/tmp/pip-jd10eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:20 INFO - Running setup.py (path:/tmp/pip-QRSZ6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:20 INFO - Running setup.py (path:/tmp/pip-TLv_GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:20 INFO - Running setup.py (path:/tmp/pip-jFl4NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:20 INFO - Running setup.py (path:/tmp/pip-V0wPvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:20 INFO - Running setup.py (path:/tmp/pip-KisbBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:21 INFO - Running setup.py (path:/tmp/pip-2MHZbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:21 INFO - Running setup.py (path:/tmp/pip-ZFLoS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:21 INFO - Running setup.py (path:/tmp/pip-WoO3gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:21 INFO - Running setup.py (path:/tmp/pip-TSAlF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:21 INFO - Running setup.py (path:/tmp/pip-eUJ2Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:21 INFO - Running setup.py install for manifestparser 01:19:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:21 INFO - Running setup.py install for mozcrash 01:19:21 INFO - Running setup.py install for mozdebug 01:19:21 INFO - Running setup.py install for mozdevice 01:19:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:21 INFO - Running setup.py install for mozfile 01:19:21 INFO - Running setup.py install for mozhttpd 01:19:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:21 INFO - Running setup.py install for mozinfo 01:19:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for mozInstall 01:19:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for mozleak 01:19:22 INFO - Running setup.py install for mozlog 01:19:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for moznetwork 01:19:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for mozprocess 01:19:22 INFO - Running setup.py install for mozprofile 01:19:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for mozrunner 01:19:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:22 INFO - Running setup.py install for mozscreenshot 01:19:22 INFO - Running setup.py install for moztest 01:19:23 INFO - Running setup.py install for mozversion 01:19:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:23 INFO - Cleaning up... 01:19:23 INFO - Return code: 0 01:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01: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')]} 01:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01: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 01: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 01:19:23 INFO - Using env: {'DISPLAY': ':0', 01:19:23 INFO - 'HOME': '/home/cltbld', 01:19:23 INFO - 'LANG': 'en_US.UTF-8', 01:19:23 INFO - 'LANGUAGE': 'en_US:en', 01:19:23 INFO - 'LOGNAME': 'cltbld', 01:19:23 INFO - 'MAIL': '/var/mail/cltbld', 01:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:23 INFO - 'MOZ_NO_REMOTE': '1', 01:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:23 INFO - 'NO_EM_RESTART': '1', 01:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:23 INFO - 'PWD': '/builds/slave/test', 01:19:23 INFO - 'SHELL': '/bin/bash', 01:19:23 INFO - 'SHLVL': '1', 01:19:23 INFO - 'TERM': 'linux', 01:19:23 INFO - 'TMOUT': '86400', 01:19:23 INFO - 'USER': 'cltbld', 01:19:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:23 INFO - '_': '/tools/buildbot/bin/python'} 01:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:23 INFO - Running setup.py (path:/tmp/pip-MVHPCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:23 INFO - Running setup.py (path:/tmp/pip-Ipmo7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:23 INFO - Running setup.py (path:/tmp/pip-FwIznx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:23 INFO - Running setup.py (path:/tmp/pip-uFwKuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:23 INFO - Running setup.py (path:/tmp/pip-t9LPKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:23 INFO - Running setup.py (path:/tmp/pip-ky3MP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:23 INFO - Running setup.py (path:/tmp/pip-OYD7QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:23 INFO - Running setup.py (path:/tmp/pip-fX0DW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:23 INFO - Running setup.py (path:/tmp/pip-wmvPaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:23 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)) 01:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:24 INFO - Running setup.py (path:/tmp/pip-tgSAg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01: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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:24 INFO - Running setup.py (path:/tmp/pip-O_R7zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01: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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:24 INFO - Running setup.py (path:/tmp/pip-LBxHV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:24 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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:24 INFO - Running setup.py (path:/tmp/pip-1RsPxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:24 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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:24 INFO - Running setup.py (path:/tmp/pip-t9crAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:24 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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:24 INFO - Running setup.py (path:/tmp/pip-Nui0IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:24 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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:24 INFO - Running setup.py (path:/tmp/pip-Q9Gs8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:24 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)) 01:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:24 INFO - Running setup.py (path:/tmp/pip-H_f07r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:24 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)) 01:19:24 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)) 01:19:24 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)) 01:19:24 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)) 01:19:24 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)) 01:19:24 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)) 01:19:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:24 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 01:19:24 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 01:19:24 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 01:19:24 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 01:19:24 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 01:19:24 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 01:19:26 INFO - Downloading blessings-1.6.tar.gz 01:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:26 INFO - Installing collected packages: blessings 01:19:26 INFO - Running setup.py install for blessings 01:19:26 INFO - Successfully installed blessings 01:19:26 INFO - Cleaning up... 01:19:26 INFO - Return code: 0 01:19:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:26 INFO - Reading from file tmpfile_stdout 01:19:26 INFO - Current package versions: 01:19:26 INFO - argparse == 1.2.1 01:19:26 INFO - blessings == 1.6 01:19:26 INFO - blobuploader == 1.2.4 01:19:26 INFO - docopt == 0.6.1 01:19:26 INFO - functools32 == 3.2.3-2 01:19:26 INFO - jsonschema == 2.5.1 01:19:26 INFO - manifestparser == 1.1 01:19:26 INFO - mozInstall == 1.12 01:19:26 INFO - mozcrash == 0.17 01:19:26 INFO - mozdebug == 0.1 01:19:26 INFO - mozdevice == 0.48 01:19:26 INFO - mozfile == 1.2 01:19:26 INFO - mozhttpd == 0.7 01:19:26 INFO - mozinfo == 0.9 01:19:26 INFO - mozleak == 0.1 01:19:26 INFO - mozlog == 3.2 01:19:26 INFO - moznetwork == 0.27 01:19:26 INFO - mozprocess == 0.22 01:19:26 INFO - mozprofile == 0.28 01:19:26 INFO - mozrunner == 6.11 01:19:26 INFO - mozscreenshot == 0.1 01:19:26 INFO - mozsystemmonitor == 0.3 01:19:26 INFO - moztest == 0.7 01:19:26 INFO - mozversion == 1.4 01:19:26 INFO - psutil == 3.1.1 01:19:26 INFO - requests == 1.2.3 01:19:26 INFO - wsgiref == 0.1.2 01:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:26 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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01:19:26 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 01:19:26 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 01:19:26 INFO - Using env: {'DISPLAY': ':0', 01:19:26 INFO - 'HOME': '/home/cltbld', 01:19:26 INFO - 'LANG': 'en_US.UTF-8', 01:19:26 INFO - 'LANGUAGE': 'en_US:en', 01:19:26 INFO - 'LOGNAME': 'cltbld', 01:19:26 INFO - 'MAIL': '/var/mail/cltbld', 01:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:26 INFO - 'MOZ_NO_REMOTE': '1', 01:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:26 INFO - 'NO_EM_RESTART': '1', 01:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:26 INFO - 'PWD': '/builds/slave/test', 01:19:26 INFO - 'SHELL': '/bin/bash', 01:19:26 INFO - 'SHLVL': '1', 01:19:26 INFO - 'TERM': 'linux', 01:19:26 INFO - 'TMOUT': '86400', 01:19:26 INFO - 'USER': 'cltbld', 01:19:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:26 INFO - '_': '/tools/buildbot/bin/python'} 01:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01: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)) 01:19:27 INFO - Cleaning up... 01:19:27 INFO - Return code: 0 01:19:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01: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')]} 01:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01: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 01: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 01:19:27 INFO - Using env: {'DISPLAY': ':0', 01:19:27 INFO - 'HOME': '/home/cltbld', 01:19:27 INFO - 'LANG': 'en_US.UTF-8', 01:19:27 INFO - 'LANGUAGE': 'en_US:en', 01:19:27 INFO - 'LOGNAME': 'cltbld', 01:19:27 INFO - 'MAIL': '/var/mail/cltbld', 01:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:27 INFO - 'MOZ_NO_REMOTE': '1', 01:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:27 INFO - 'NO_EM_RESTART': '1', 01:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:27 INFO - 'PWD': '/builds/slave/test', 01:19:27 INFO - 'SHELL': '/bin/bash', 01:19:27 INFO - 'SHLVL': '1', 01:19:27 INFO - 'TERM': 'linux', 01:19:27 INFO - 'TMOUT': '86400', 01:19:27 INFO - 'USER': 'cltbld', 01:19:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:27 INFO - '_': '/tools/buildbot/bin/python'} 01:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:27 INFO - Cleaning up... 01:19:27 INFO - Return code: 0 01:19:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfcfe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, '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': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', '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 01: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', 'flake8'] in /builds/slave/test/build 01: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 flake8 01:19:27 INFO - Using env: {'DISPLAY': ':0', 01:19:27 INFO - 'HOME': '/home/cltbld', 01:19:27 INFO - 'LANG': 'en_US.UTF-8', 01:19:27 INFO - 'LANGUAGE': 'en_US:en', 01:19:27 INFO - 'LOGNAME': 'cltbld', 01:19:27 INFO - 'MAIL': '/var/mail/cltbld', 01:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:27 INFO - 'MOZ_NO_REMOTE': '1', 01:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:27 INFO - 'NO_EM_RESTART': '1', 01:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:27 INFO - 'PWD': '/builds/slave/test', 01:19:27 INFO - 'SHELL': '/bin/bash', 01:19:27 INFO - 'SHLVL': '1', 01:19:27 INFO - 'TERM': 'linux', 01:19:27 INFO - 'TMOUT': '86400', 01:19:27 INFO - 'USER': 'cltbld', 01:19:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:27 INFO - '_': '/tools/buildbot/bin/python'} 01:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:27 INFO - Downloading/unpacking flake8 01:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:19:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:19:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:30 INFO - no previously-included directories found matching 'docs/_build' 01:19:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:19:30 INFO - Running setup.py install for pep8 01:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:30 INFO - no previously-included directories found matching 'docs/_build' 01:19:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:19:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:19:30 INFO - Cleaning up... 01:19:31 INFO - Return code: 0 01:19:31 INFO - Running post-action listener: _resource_record_post_action 01:19:31 INFO - Running post-action listener: _start_resource_monitoring 01:19:31 INFO - Starting resource monitoring. 01:19:31 INFO - ##### 01:19:31 INFO - ##### Finished create-virtualenv step (success) 01:19:31 INFO - ##### 01:19:31 INFO - ##### 01:19:31 INFO - ##### Running install step. 01:19:31 INFO - ##### 01:19:31 INFO - Running pre-action listener: _resource_record_pre_action 01:19:31 INFO - Running main action method: install 01:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:31 INFO - Reading from file tmpfile_stdout 01:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 01:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:19:31 INFO - Reading from file tmpfile_stdout 01:19:31 INFO - Output received: 01:19:31 INFO - Usage: mozinstall [options] installer 01:19:31 INFO - Options: 01:19:31 INFO - -h, --help show this help message and exit 01:19:31 INFO - -d DEST, --destination=DEST 01:19:31 INFO - Directory to install application into. [default: 01:19:31 INFO - "/builds/slave/test"] 01:19:31 INFO - --app=APP Application being installed. [default: firefox] 01:19:31 INFO - mkdir: /builds/slave/test/build/application 01: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'] 01: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 01:19:47 INFO - Reading from file tmpfile_stdout 01:19:47 INFO - Output received: 01:19:47 INFO - /builds/slave/test/build/application/firefox/firefox 01:19:47 INFO - Running post-action listener: _resource_record_post_action 01:19:47 INFO - ##### 01:19:47 INFO - ##### Finished install step (success) 01:19:47 INFO - ##### 01:19:47 INFO - ##### 01:19:47 INFO - ##### Running run-tests step. 01:19:47 INFO - ##### 01:19:47 INFO - Running pre-action listener: _resource_record_pre_action 01:19:47 INFO - Running main action method: run_tests 01:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:47 INFO - Python 2.7.3 01:19:47 INFO - Return code: 0 01:19:47 INFO - grabbing minidump binary from tooltool 01: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')]} 01: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 0x297e1c0>, '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 0x297f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01: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 01: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 01: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 01:19:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:47 INFO - Return code: 0 01:19:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:19:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:19:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:19:48 INFO - Return code: 0 01: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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 01: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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 01:19:48 INFO - Using env: {'DISPLAY': ':0', 01:19:48 INFO - 'HOME': '/home/cltbld', 01:19:48 INFO - 'LANG': 'en_US.UTF-8', 01:19:48 INFO - 'LANGUAGE': 'en_US:en', 01:19:48 INFO - 'LOGNAME': 'cltbld', 01:19:48 INFO - 'MAIL': '/var/mail/cltbld', 01:19:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:48 INFO - 'MOZ_NO_REMOTE': '1', 01:19:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:48 INFO - 'NO_EM_RESTART': '1', 01:19:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:48 INFO - 'PWD': '/builds/slave/test', 01:19:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:48 INFO - 'SHELL': '/bin/bash', 01:19:48 INFO - 'SHLVL': '1', 01:19:48 INFO - 'TERM': 'linux', 01:19:48 INFO - 'TMOUT': '86400', 01:19:48 INFO - 'USER': 'cltbld', 01:19:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343', 01:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:48 INFO - '_': '/tools/buildbot/bin/python'} 01: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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 01:19:48 INFO - mozversion application_buildid: 20160627130921 01:19:48 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:19:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:48 INFO - mozversion application_name: Firefox 01:19:48 INFO - mozversion application_remotingname: firefox-dev 01:19:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:48 INFO - mozversion application_vendor: Mozilla 01:19:48 INFO - mozversion application_version: 49.0a2 01:19:48 INFO - mozversion platform_buildid: 20160627130921 01:19:48 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:48 INFO - mozversion platform_version: 49.0a2 01:19:48 INFO - using testdate: 1467101988 01:19:48 INFO - actual date: 1467101988 01:19:48 INFO - starting webserver on 'localhost:60185' 01:19:48 INFO - SUITE-START | Running 2 tests 01:19:48 INFO - TEST-START | dromaeo_css 01:19:48 INFO - operating with platform_type : linux_ 01:19:48 INFO - Initialising browser for dromaeo_css test... 01:19:48 INFO - TEST-INFO | started process 1760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAQlCpo/profile http://localhost:60185/getInfo.html) 01:19:55 INFO - PROCESS | 1760 | __metrics Screen width/height:1600/1200 01:19:55 INFO - PROCESS | 1760 | colorDepth:24 01:19:55 INFO - PROCESS | 1760 | Browser inner width/height: 1024/697 01:19:55 INFO - PROCESS | 1760 | __metrics 01:19:56 ERROR - PROCESS | 1760 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:19:57 INFO - TEST-INFO | 1760: exit 0 01:19:57 INFO - Browser initialized. 01:19:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:19:57 INFO - TEST-INFO | started process 1892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAQlCpo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:09 INFO - PROCESS | 1892 | RSS: Main: 155570176 01:20:09 INFO - PROCESS | 1892 | 01:20:58 INFO - PROCESS | 1892 | 1467102058810 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] 01:23:07 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60185/tests/dromaeo/cssquery-ext.html) 01:23:08 INFO - PROCESS | 1892 | RSS: Main: 159064064 01:23:08 INFO - PROCESS | 1892 | 01:26:10 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-ext.html (next: http://localhost:60185/tests/dromaeo/cssquery-jquery.html) 01:26:10 INFO - PROCESS | 1892 | RSS: Main: 157151232 01:26:10 INFO - PROCESS | 1892 | 01:29:12 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60185/tests/dromaeo/cssquery-mootools.html) 01:29:13 INFO - PROCESS | 1892 | RSS: Main: 157327360 01:29:13 INFO - PROCESS | 1892 | 01:32:14 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60185/tests/dromaeo/cssquery-prototype.html) 01:32:15 INFO - PROCESS | 1892 | RSS: Main: 156401664 01:32:15 INFO - PROCESS | 1892 | 01:35:18 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60185/tests/dromaeo/cssquery-yui.html) 01:35:18 INFO - PROCESS | 1892 | RSS: Main: 159014912 01:35:18 INFO - PROCESS | 1892 | 01:38:20 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:60185/tests/dromaeo/cssquery-yui.html (next: http://localhost:60185/tests/dromaeo/cssquery-dojo.html) 01:38:21 INFO - PROCESS | 1892 | RSS: Main: 158756864 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | __start_tp_report 01:38:21 INFO - PROCESS | 1892 | _x_x_mozilla_page_load 01:38:21 INFO - PROCESS | 1892 | _x_x_mozilla_page_load_details 01:38:21 INFO - PROCESS | 1892 | |i|pagename|runs| 01:38:21 INFO - PROCESS | 1892 | |0;dojo.html;3416.043507817811;3477.37407266692;3480.5649293838287;3495.3358861816255;3505.456654218597;5811.535077193825;5848.005839007363;5868.911966320503;5902.970485147568;5936.88126237475;5882.911756323659;5911.586188966774;5912.083627037805;5928.347881733006;5931.88136237275;5252.947470525303;5337;5396.271503347057;5402.216678581623;5405.081136206854;5254.737263136847;5259.079661059319;5307.65500242483;5390.299261096052;5405.162199859008;5255.658382205163;5258.947410525903;5261.868453288679;5283.101872681634;5302.390225124122;5235.293235413227;5286.07493688603;5317.601179911522;5324.094903866352;5344;5132.127538318495;5138.897222055575;5212.348456442945;5243.213517972296;5299.947000530023;5678.943210567924;5756.136579513065;5790.7104644768015;5804.071348584206;5810.33181184165;6342.968285158545;6363.7772677956045;6370.140031095835;6377.330380310047;6389.233292004943;6114.054067497291;6135.754569817202;6136.3965394158;6398.968005159991;6414.647194404306;5819.359870414251;5821.563382746311;5830.854228644275;5836.562257830679;5855.063189889597;6336.334684858116;6370.044493326038;6376.426121649074;6388.393102655334;6391.3289104643345;5993.520518358521;6085.056816193409;6096.237970253718;6099.634021958696;6121.84695382619;6212.502999760099;6265.122882796412;6271.749130034838;6277.96861015692;6278.340774218733;6136.355682653347;6250.9062364064575;6260.655663938436;6262.091996660459;6269;6058.878822423527;6203.937960620427;6214.502839772807;6251.78118765841;6373.74505019794;4796.592289655348;4798.23228283473;4805.423349198119;4812.975935120302;4828.7102773833685;4151.398047283127;4251.59609837065;4284.121755040209;4285.142971405731;4328.026194106364;5847.415258474203;5903.291605007426;5927.555433342516;5945.2865656120675;5970.104484327386;6217.036359364306;6223.941929871932;6314.842128946813;6325.810225693236;6343.5876668016435;5895.616784908967;6016.518678505709;6020.8795824084145;6026.306974697965;6032.728527216286;5322.654027488201;5344.545713614386;5360.865978350573;5376.731163441812;5425.294711687456;6489.545731798823;6545.050967609765;6546.116274302908;6555.3772391622715;6560.245571759213;6041.2750469943885;6259.593126446766;6338.714757836001;6362.204724409449;6362.968185159045;6449.580777249464;6579.407853293226;6579.934200657932;6590.340965903371;6593.571417858016;6275.027370757357;6282.434580887742;6284.3087260402235;6286.905696414649;6310.52671049664;6141.232345956755;6232.875342493216;6251.062340648939;6414.166158399378;6423.42189202974;6188.133661287334;6188.2883468399905;6210.4100110489435;6238.937610624017;6241.625502469685;6215.595986260879;6218.160548325918;6233.470155036873;6233.625982441068;6244.375562443719;5839.649621022752;5966.701664916824;5973.761049557969;6014.57897947157;6077.453029227391;6188.226471691039;6196.597221180609;6228.252609686867;6236.844078898064;6247.437730604267;6068.787592434243;6081.6351018939;6091.451769340781;6097.939020609737;6104.20971395849 01:38:21 INFO - PROCESS | 1892 | |1;ext.html;580.8780156167205;631.3497097989072;638.9169407976963;649.4706813946631;658.2298710508705;47269;48683.999999999956;48736.51263487364;51600;51687.22469162966;48549.51450485494;48787.75606121965;48921.26618100731;49134.75432622832;49243.26135107967;9200.53997300134;9351.812963740722;9357.625694972194;9361.391509551857;9372.297077719164;9142.771430714252;9157.771055723593;9238.076192380742;9238.30712696547;9250.67622633208;9232.169104780569;9254.86117708235;9294.628214871396;9299.209567186797;9299.349045566812;9229.861552076723;9261.120193581599;9276.90723092774;9279.257659387233;9295.024022477677;9075.954620226923;9165.908340916572;9167.12912273333;9171.816563668755;9181;45434.54565454369;45490.54509454929;45915.311270330974;45980.54019459796;45997.310040349425;3997.5402828674783;4067.8983025424304;4103.610157035107;4239.342901850218;4492.707973981714;34907.82546087279;35077.82461087704;35428.114297142776;35707.28585428303;35900.28199436023;4683.953160468386;4730.266808644666;4758.262469317261;4788.976055119702;4803.471618122004;400146;400525;400991;401351.9999999971;401483;38516.42225366622;66267.66866165638;66853;66896;66947;40970;41103;41189.38215926763;41242.79378603088;41341.79329103395;17680.381186658404;18039.458816235532;18045.7293140603;18057.09714514269;18076.72884906701;14655.780163297559;14716.852831471762;14826.110433373817;14862.777058344134;14892.553223403314;9170.541472926461;9207.861882071775;9220.170184683411;9272.953635231781;9311.115444032806;3414.7438942079443;3521.1901262709207;3546.280054173724;3568.6966607838103;3623.7463377563845;1117.586492997596;1124.16249893828;1142.868570114431;1183.6094088950626;1264.6964728465102;35116.64883351185;35256.82371588177;35309.823450882584;35681.28637427237;35823.82088089595;1144.6909334479644;1189.29831399473;1221.8961388282096;1266.3541593787236;1278.5013844600612;17944.641107178046;18106.728399074025;18181.81818181828;18198.272069117353;18357.3574924877;714082;714343;725143;965513;1044171;68934;68947.31052689509;69158;69462;69491;1503.4737841755298;1506.758918573023;1507.5854140111337;1512.1834209526953;1522.91623960681;34852.825735871156;35207.82396088003;35419.64580354266;35482.822585886905;35485.82257088698;58977.11534327074;59407;59504;59826.70086649539;59984.700076499335;582384;584140;584823;585821;586961;32149.839250803598;32569.511457327684;32707.836460817543;33038.5044224332;33191.33617327688;54312.18531721948;55178.44821551733;55452;56125.438745612024;56419.43580564142;45694.31458528058;45883.770581146884;46390.30414543717;46600.53399465962;47100;45225.60440437314;45660.086798264514;45690;46197;47530.52469475399;45502;46516.53483465122;46777.76611116923;46928;47034.059318812746;38746.41880371853;40138.79930600328;40608.390874137505;40803.1839363217;41444.79277603713;30372.24069398283;30823.2294192638;31036;31236.687633124286;31299.217519562193 01:38:21 INFO - PROCESS | 1892 | |2;jquery.html;431.72801135284766;434.30077575104076;439.2364803703833;439.44849214236126;444.1272898753948;18878.716819247704;19814.90092549537;20750.377488675345;20907.268245611405;20967;19097.23611055556;19570.902145489254;20329.28847490338;20408.693869591967;20441;5824.650520968745;5985.940140598582;6022.2773267207995;6023.759049638009;6048.788292409767;5754.913676294838;5924.259467566554;5945.197398351233;5972.731227094791;5994.490468310199;5886.352501224862;5899.174115623816;5902.675352855591;5906.527477801766;5917.260342457193;5659.886802263953;5873.412658734135;5884.852878678067;5909.231799866033;5910.88178236435;5316.38861530925;5331.653442526263;5340.49265319794;5342.973285133588;5363.034653762321;15200.087994720241;16126;21623.135074596998;22735.54528909429;22769.203077892194;2307.411610039446;2376.239603326936;2475.356407334088;2522.6089956056658;2574.742525747429;10414.583416663325;10714.250002499828;11234.719132021683;11604.477798499087;15623.218839058001;2020.7575090989028;2030.5938812237464;2041.101915157326;2080.6566916458764;2115.5663089066707;86564.56717716371;86726.56636716839;86952;86962.56518717366;88381.11618883793;11943.701407464883;12223;12291.56979505713;12379.257244565355;13096.279704616338;16725.498235052968;16922.069286189377;16956.321747130223;17009;17026.31894724222;8853.601587928559;9072.092790720875;9147.954260228656;9256.935452422922;9339.206167475704;8819.911800882037;8846.690365837165;8860.822783544292;8912.68805591814;9146.451212927246;5031.421386540522;5071.670341427795;5215.634905556651;5330.493603107699;5352.2506849041165;2125.4048866317457;2135.6689713094183;2194.7585765566096;2210.728830922194;2239.2386588559966;985.4678473624306;1010.7523656704154;1079.6760971708457;1081.8918108189275;1102.3385968418884;19839.404817855488;19915;20385.592288154156;20493;20497.38507844767;1058.5342449322427;1059.4914441068331;1074.2372915230274;1091.6179337232063;1103.3710784852558;10935.234533582572;11316.886831131584;11356.432178391213;11533.192676512563;11564.768704626029;529206;595100;595108;597597;631196;104905;107989.46005269923;111683.44158279157;112264;113021.43489282501;533.3067012883237;551.0246863052455;552.1414200917611;553.8975289571442;554.3043480432032;11470.311781293149;12090.395480226129;12386.256824590553;12483.625491235278;12509.124361294622;43758.343624845016;44801.55198448104;45328.32007519956;45662.77168614269;48194;62965.68517157385;63262;63496;64705.67647161734;65239.673801630684;9282.118198771106;9427.528623568656;9462.858057129286;9493.335466517277;9663.613455461702;13180.802287965496;14116.78824817608;14165.575032749033;14203.928980355033;14251.287435628385;12365.319907405179;12373.690657733629;12418.316992565135;12543.24740515572;12609.747805043664;9077.727668169966;11885.702857428634;12203.877961220629;12442.129050966345;12567.245965242115;12467.251964882136;12563.371831408576;12609.30648814324;12634.115611907078;12771.489140434278;9338.719838404859;9377.156055954996;9396.67111651089;9548.713538593853;9659.613615455302;9931.801363972536;12551.184173028723;12574.434150463434;12835.42240599194;12901.290429026494 01:38:21 INFO - PROCESS | 1892 | |3;mootools.html;1579;1607.7347237705778;1827.552249698824;1921.4235729281213;1929.3922414439442;9277.211437027852;9850.507474626267;9858.359206651563;9887.950560247189;9985.450800205987;10351.275410721253;10368.06687398134;10397.532111055001;10495.73760655982;10496.580136794519;2582.65134206882;2616.6336712860216;2621.9344516387146;2627.6189952456884;2628.2640860559072;2522.054229663876;2563.4873025394904;2566.2429583272888;2566.6278389633494;2570.755778201077;2545.7836083932793;2552.8595927223996;2573.0608327960254;2574.9227523174336;2581.0063125696556;2511.359603301156;2524.5203411351786;2537.9873100634563;2561.3468565515673;2569.7687208151356;2445.9877700611382;2476.3932836455006;2489.103922587885;2517.886695098725;2533.67062281904;9731.610735570568;9817.607295708163;9817.656382026595;9828.21374290055;9849;5775.826725198251;5788.82633520995;5811.27359080115;5814.186013958049;5975.671338076404;3535.7524973251884;3676.4117741161285;3707;3712.053426376284;3742.5883152853166;1133.1557989297944;1146.6273461125168;1154.832549280358;1157.5254145800182;1177.911656625748;13909.165450072927;13914.582562523141;14004.859951400458;14017.579472615736;14108.365123569361;5004.099262132851;5090.185570308733;5112.309838171799;5149.588032957355;5178.223266510054;10638.840417393745;10646.041856232976;10646.627368042082;10746.247762656696;10758.193135514868;5625.296837895263;5632.295963004624;5681.9431805681415;5691.857703557444;5692.48767610917;4809.9038019239415;5261.263423120766;5272;5391.029614669397;5392.514673679388;4245.724027938236;4271.850485233002;4325.545817689097;4358.476982762026;4394.736315821061;1242.4098553187164;1294.4951468927127;1296.857345691973;1305.2299143505377;1309.646395473217;876.5354362188051;948.7675519497767;969.6557722008727;970.8058388322364;980.6273616025865;6241.937580624226;6258.499320054385;6266.122742816009;6294.3076261612105;6353.841153971188;493.14685593921996;495.7422140486927;505.8634168774484;508.3569284854662;517.0434695812717;4348.369486424451;4350.891227719269;4395.1868904252815;4396.692231543825;4410.448693913261;12435.502579896884;12813.807792883114;12819.1026628137;12845.935770321088;12908.419121139383;12420.254784712946;12685.048621353435;12703.364831758376;12716.300603466712;12765.680857978625;9313.161815436642;9336.9262534808;9380.061993800702;9388.295877809192;9416.152546270869;6274.498040156868;6305.905411418924;6362;6405.135306733718;6415.422611964946;10684.09185219234;11623.476943537393;11653.592124275949;11848;11920.52317907274;11175.776484470103;11322.094232461219;11332.716682083013;11372.488238029144;11468.82796758066;8488.448250863674;8862.822743544964;8951.373403861668;9066.773330666521;9087.36388452802;9322.067793220624;9364.719058428258;9410.247180225702;9451.149396554343;9455;8440.324774017941;8475.194856488624;8595.140485951355;8636.222739953435;8656.78358041054;7726.9227307726205;7771.494852834548;8169.754907352789;8216.876746848682;8257.21556452136;7355.190928997699;7364.153122390993;7366.079240094989;7366.189719130998;7366.373858222111;5477.068898287381;5477.397486276427;5568.832935011957;5595.440455954372;5619.2133101365025;5280.128778751463;5309.389420216725;5416.729163541886;5505.449455054462;5551.639143455663 01:38:21 INFO - PROCESS | 1892 | |4;prototype.html;356.61663711510124;361.69075440498375;366.8165917041479;367.6433859156617;371.71192325947385;5875;5901.557383196256;5920.963831329522;5921.378255283193;5937.970310148454;5445.863853403657;5718.799052199043;5789.855253618662;5793.884122317551;5824.835032993397;4482.462104547442;4484.59638632523;4497.437820272466;4504.932426013613;4523.208438523262;4500.672301671015;4506.324051392301;4522.09558088382;4536.56902594253;4537.183307004738;4405.405270288518;4455.086707225028;4486.147631949935;4515.593596576307;4527.932081018771;4415.381846541487;4439.622632076277;4440.4893437254805;4445.444319460067;4465.866024019285;3882.951603067156;3914.9608503914883;3917.158935300404;3940;3955.7033222508426;5617.38208797032;5647.830565083054;5648.548116150698;5667.603267771257;5711.886182194474;4886.780094895738;5163.927463159414;5174.379074511083;5190.688558686453;5197.58419326453;6037.245344331958;6096.969515152396;6125.908111378333;6153.261608606996;6180.218901494301;4127.587241275878;4380.532521605266;4387.254166791653;4393.736375817429;4415.911681766379;6081.331053584102;6222.284437289679;6333.303336632966;6380.425761681471;6392.808215753488;4364.8254069837485;4382.69321147523;4417.337399390053;4422.474246384992;4442.311441726538;4407.338899165151;4478.350639157369;4482.417285752831;4484.798184081724;4510.819567217341;4885.291632713237;5095.719735414514;5160.7935682573025;5182.792688292501;5194.454582268883;6098.72555734993;6106.45041946218;6112.908306375408;6116.388361163937;6138.232720909887;1547.2959803289477;1562.9140397278031;1568.239403889113;1569.6625225576556;1570;953.5327689432129;984.7981163861391;994.3238597753452;999.7403271877487;1005.7930483419925;5260.684358938476;5262.236975638511;5317.760700768475;5324.893502129936;5383.308345827087;5527;5552.7778888844805;5555.749991250404;5634.85912852182;5696.23100881384;5194.818181363634;5304.469553044664;5503.504684578407;5971.164037034819;5985.940140598538;3318.402687516222;3368.983155084209;3372.6121496028272;3375.6624337566536;3377.763556551067;6296.866564018429;6505.4795616350575;6529.249136349285;6553.475721942234;6571.244306904671;6467.870642587122;6491;6520.576162549419;6521;6564.967175164189;6282.937170628326;6472.190976127984;6541.443977261891;6542.182227221598;6563.803085907431;6235.750569977332;6289.433950944437;6328.936710632835;6394.392532709385;6397.168368112116;5950.553708471795;6267.2165979252595;6289.182406287337;6291.96854015727;6324.1146239527425;6347.636247371149;6473.385028422293;6474.320196379313;6538.607683539003;6543.149390579194;4461.13007963444;4461.598456138963;4463.085067561207;4473.852550775711;4494.6629002825575;6071.332153463027;6278.686065696788;6307.936920630735;6331.303556608677;6331.398517140864;6093.268807743099;6133.202683651275;6136.355682653257;6147.415995480422;6151.96924015377;5837.503812176013;6018.699065046818;6062.514998799998;6098.603590766586;6099.817005489843;5987.7604895805425;6009.429104235091;6018;6019.367966363468;6048.153258543895;6073.726682299219;6112.572119951738;6180.969095154675;6192.59748116389;6204.565680402328;5759.798407055733;5992.850178745566;6038.426349496791;6043.640180959249;6052 01:38:21 INFO - PROCESS | 1892 | |5;yui.html;831.1356189562855;836.8912041434612;876.9912300876991;899.0380293086392;925.2459245714742;17369;18421.447356579323;18458.446246612606;18472.722909156375;18501.907490462545;16739.66520669586;16951;17044.744328835077;17229.569260768487;17652.38216662417;843.1105184030845;844.7676888855552;846.5047946951041;847.516915358246;849.524266410812;813.6704634622987;822.3873214455239;822.880682301066;824.3116997307255;828.1801016993163;915.4690279637794;918.4305730447132;918.6325469812095;919.2278486071698;920.7513971227764;900.131373224838;905.0180554098778;905.0723008915849;906.9863952040724;908.0329449136682;652.8465810534568;654.1757385694012;658.8912829383146;659.1859054068221;660.3099760750027;14221.857781422157;14672.413103475848;14718.779218311734;14742.70514589713;14841.554753357417;15285.847141528553;15465.226738663134;15555.766663500057;15858.286377113058;15872.12703301318;12216.633500994983;12445.191062580903;12514.18657787241;12527.18573292733;12706.301153436558;3959.287328280937;3977.065389633434;4010.3783913493453;4022.1955608878343;4163.042500224935;69581.65209173973;73277.6336118316;73709.63145184293;77451.6127419365;84627.57686211653;11150.330980141218;11424.885751142383;11693.88306116945;11727.237729547724;12335.938320308342;22668.546629067325;22973;23066;23067.653985190234;23168.073277069067;9395.154436100784;9435.292353073546;9451.905480945241;9551.235901127893;9556.426614403159;5105.566026887756;5147.794088236504;5226.137687281632;5272.499112584298;5434.456554344534;3799.7340186187253;3858.3247931611854;3901.2197560488016;3902.180542086137;3902.551206611276;665.7203974330793;682.2052309059989;683.5625199872086;694.3160986428364;707.2291202589203;672.5863593889723;820.5733018830175;827.5241736001823;833.4291010657598;838.3251334036902;10328.793424131476;10383.428911409945;10759.3544387337;10779.137668986463;10975;698.6262349642917;745.2175216023262;798.604690678118;814.8207394373228;819.0949001353538;5039.294498770175;5050.242463630411;5064.316317297192;5121.052605268037;5311.150215965427;99181;100270;102325;113515;119177.40411297888;95625;96051;96170;96413;97596.51201744088;85265;87053.56473217593;89533.55233223923;90237.99999999869;92431;9960.352577082467;10421.68734937953;10622.575096996034;10841.837372439577;10858.2399232053;39041.80479097586;42402.15195696131;47085.293720594906;49319.260211096145;52323.47676523186;79271;79994;80320.59839700763;81137;81545.77681334903;14133.646658833612;14192.219427931563;14237.359318830884;14349.856501434851;14522.419103235752;13280.80078798838;13583.660408489472;13621.795673064713;13723.656908577366;13760.65598360049;14180.929095354457;14832.492885316118;14902.552923412315;14925.776113358526;14927.179005154821;13361.13152645075;13364.665883352995;13722.382492787649;13767.793483097561;13873.098248613807;13612.523561675294;13819.654508636962;14481.913856461018;14716.484923027643;14811.851881481047;10863.456827158452;10998.230123891251;11728.472218750007;12058.879411205775;12320.260784352968;11365.204435689422;12109.816839640594;12141.392930353624;12191.207571507824;12444.564440244549 01:38:21 INFO - PROCESS | 1892 | __end_tp_report 01:38:21 INFO - PROCESS | 1892 | __start_cc_report 01:38:21 INFO - PROCESS | 1892 | _x_x_mozilla_cycle_collect,343 01:38:21 INFO - PROCESS | 1892 | __end_cc_report 01:38:21 INFO - PROCESS | 1892 | __startTimestamp1467103101140__endTimestamp 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | ------- Summary: start ------- 01:38:21 INFO - PROCESS | 1892 | Number of tests: 6 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#0] dojo.html Cycles:165 Average:5830.75 Median:6068.79 stddev:667.32 (11.0%) stddev-sans-first:641.92 01:38:21 INFO - PROCESS | 1892 | Values: 3416.0 3477.4 3480.6 3495.3 3505.5 5811.5 5848.0 5868.9 5903.0 5936.9 5882.9 5911.6 5912.1 5928.3 5931.9 5252.9 5337.0 5396.3 5402.2 5405.1 5254.7 5259.1 5307.7 5390.3 5405.2 5255.7 5258.9 5261.9 5283.1 5302.4 5235.3 5286.1 5317.6 5324.1 5344.0 5132.1 5138.9 5212.3 5243.2 5299.9 5678.9 5756.1 5790.7 5804.1 5810.3 6343.0 6363.8 6370.1 6377.3 6389.2 6114.1 6135.8 6136.4 6399.0 6414.6 5819.4 5821.6 5830.9 5836.6 5855.1 6336.3 6370.0 6376.4 6388.4 6391.3 5993.5 6085.1 6096.2 6099.6 6121.8 6212.5 6265.1 6271.7 6278.0 6278.3 6136.4 6250.9 6260.7 6262.1 6269.0 6058.9 6203.9 6214.5 6251.8 6373.7 4796.6 4798.2 4805.4 4813.0 4828.7 4151.4 4251.6 4284.1 4285.1 4328.0 5847.4 5903.3 5927.6 5945.3 5970.1 6217.0 6223.9 6314.8 6325.8 6343.6 5895.6 6016.5 6020.9 6026.3 6032.7 5322.7 5344.5 5360.9 5376.7 5425.3 6489.5 6545.1 6546.1 6555.4 6560.2 6041.3 6259.6 6338.7 6362.2 6363.0 6449.6 6579.4 6579.9 6590.3 6593.6 6275.0 6282.4 6284.3 6286.9 6310.5 6141.2 6232.9 6251.1 6414.2 6423.4 6188.1 6188.3 6210.4 6238.9 6241.6 6215.6 6218.2 6233.5 6233.6 6244.4 5839.6 5966.7 5973.8 6014.6 6077.5 6188.2 6196.6 6228.3 6236.8 6247.4 6068.8 6081.6 6091.5 6097.9 6104.2 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#1] ext.html Cycles:180 Average:75601.88 Median:45947.93 stddev:171250.92 (372.7%) stddev-sans-first:171638.69 01:38:21 INFO - PROCESS | 1892 | Values: 580.9 631.3 638.9 649.5 658.2 47269.0 48684.0 48736.5 51600.0 51687.2 48549.5 48787.8 48921.3 49134.8 49243.3 9200.5 9351.8 9357.6 9361.4 9372.3 9142.8 9157.8 9238.1 9238.3 9250.7 9232.2 9254.9 9294.6 9299.2 9299.3 9229.9 9261.1 9276.9 9279.3 9295.0 9076.0 9165.9 9167.1 9171.8 9181.0 45434.5 45490.5 45915.3 45980.5 45997.3 3997.5 4067.9 4103.6 4239.3 4492.7 34907.8 35077.8 35428.1 35707.3 35900.3 4684.0 4730.3 4758.3 4789.0 4803.5 400146.0 400525.0 400991.0 401352.0 401483.0 38516.4 66267.7 66853.0 66896.0 66947.0 40970.0 41103.0 41189.4 41242.8 41341.8 17680.4 18039.5 18045.7 18057.1 18076.7 14655.8 14716.9 14826.1 14862.8 14892.6 9170.5 9207.9 9220.2 9273.0 9311.1 3414.7 3521.2 3546.3 3568.7 3623.7 1117.6 1124.2 1142.9 1183.6 1264.7 35116.6 35256.8 35309.8 35681.3 35823.8 1144.7 1189.3 1221.9 1266.4 1278.5 17944.6 18106.7 18181.8 18198.3 18357.4 714082.0 714343.0 725143.0 965513.0 1044171.0 68934.0 68947.3 69158.0 69462.0 69491.0 1503.5 1506.8 1507.6 1512.2 1522.9 34852.8 35207.8 35419.6 35482.8 35485.8 58977.1 59407.0 59504.0 59826.7 59984.7 582384.0 584140.0 584823.0 585821.0 586961.0 32149.8 32569.5 32707.8 33038.5 33191.3 54312.2 55178.4 55452.0 56125.4 56419.4 45694.3 45883.8 46390.3 46600.5 47100.0 45225.6 45660.1 45690.0 46197.0 47530.5 45502.0 46516.5 46777.8 46928.0 47034.1 38746.4 40138.8 40608.4 40803.2 41444.8 30372.2 30823.2 31036.0 31236.7 31299.2 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#2] jquery.html Cycles:180 Average:32915.32 Median:22752.37 stddev:97377.03 (428.0%) stddev-sans-first:97619.65 01:38:21 INFO - PROCESS | 1892 | Values: 431.7 434.3 439.2 439.4 444.1 18878.7 19814.9 20750.4 20907.3 20967.0 19097.2 19570.9 20329.3 20408.7 20441.0 5824.7 5985.9 6022.3 6023.8 6048.8 5754.9 5924.3 5945.2 5972.7 5994.5 5886.4 5899.2 5902.7 5906.5 5917.3 5659.9 5873.4 5884.9 5909.2 5910.9 5316.4 5331.7 5340.5 5343.0 5363.0 15200.1 16126.0 21623.1 22735.5 22769.2 2307.4 2376.2 2475.4 2522.6 2574.7 10414.6 10714.3 11234.7 11604.5 15623.2 2020.8 2030.6 2041.1 2080.7 2115.6 86564.6 86726.6 86952.0 86962.6 88381.1 11943.7 12223.0 12291.6 12379.3 13096.3 16725.5 16922.1 16956.3 17009.0 17026.3 8853.6 9072.1 9148.0 9256.9 9339.2 8819.9 8846.7 8860.8 8912.7 9146.5 5031.4 5071.7 5215.6 5330.5 5352.3 2125.4 2135.7 2194.8 2210.7 2239.2 985.5 1010.8 1079.7 1081.9 1102.3 19839.4 19915.0 20385.6 20493.0 20497.4 1058.5 1059.5 1074.2 1091.6 1103.4 10935.2 11316.9 11356.4 11533.2 11564.8 529206.0 595100.0 595108.0 597597.0 631196.0 104905.0 107989.5 111683.4 112264.0 113021.4 533.3 551.0 552.1 553.9 554.3 11470.3 12090.4 12386.3 12483.6 12509.1 43758.3 44801.6 45328.3 45662.8 48194.0 62965.7 63262.0 63496.0 64705.7 65239.7 9282.1 9427.5 9462.9 9493.3 9663.6 13180.8 14116.8 14165.6 14203.9 14251.3 12365.3 12373.7 12418.3 12543.2 12609.7 9077.7 11885.7 12203.9 12442.1 12567.2 12467.3 12563.4 12609.3 12634.1 12771.5 9338.7 9377.2 9396.7 9548.7 9659.6 9931.8 12551.2 12574.4 12835.4 12901.3 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#3] mootools.html Cycles:180 Average:6412.17 Median:2651.53 stddev:3786.95 (142.8%) stddev-sans-first:3780.16 01:38:21 INFO - PROCESS | 1892 | Values: 1579.0 1607.7 1827.6 1921.4 1929.4 9277.2 9850.5 9858.4 9888.0 9985.5 10351.3 10368.1 10397.5 10495.7 10496.6 2582.7 2616.6 2621.9 2627.6 2628.3 2522.1 2563.5 2566.2 2566.6 2570.8 2545.8 2552.9 2573.1 2574.9 2581.0 2511.4 2524.5 2538.0 2561.3 2569.8 2446.0 2476.4 2489.1 2517.9 2533.7 9731.6 9817.6 9817.7 9828.2 9849.0 5775.8 5788.8 5811.3 5814.2 5975.7 3535.8 3676.4 3707.0 3712.1 3742.6 1133.2 1146.6 1154.8 1157.5 1177.9 13909.2 13914.6 14004.9 14017.6 14108.4 5004.1 5090.2 5112.3 5149.6 5178.2 10638.8 10646.0 10646.6 10746.2 10758.2 5625.3 5632.3 5681.9 5691.9 5692.5 4809.9 5261.3 5272.0 5391.0 5392.5 4245.7 4271.9 4325.5 4358.5 4394.7 1242.4 1294.5 1296.9 1305.2 1309.6 876.5 948.8 969.7 970.8 980.6 6241.9 6258.5 6266.1 6294.3 6353.8 493.1 495.7 505.9 508.4 517.0 4348.4 4350.9 4395.2 4396.7 4410.4 12435.5 12813.8 12819.1 12845.9 12908.4 12420.3 12685.0 12703.4 12716.3 12765.7 9313.2 9336.9 9380.1 9388.3 9416.2 6274.5 6305.9 6362.0 6405.1 6415.4 10684.1 11623.5 11653.6 11848.0 11920.5 11175.8 11322.1 11332.7 11372.5 11468.8 8488.4 8862.8 8951.4 9066.8 9087.4 9322.1 9364.7 9410.2 9451.1 9455.0 8440.3 8475.2 8595.1 8636.2 8656.8 7726.9 7771.5 8169.8 8216.9 8257.2 7355.2 7364.2 7366.1 7366.2 7366.4 5477.1 5477.4 5568.8 5595.4 5619.2 5280.1 5309.4 5416.7 5505.4 5551.6 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#4] prototype.html Cycles:180 Average:5095.34 Median:5739.30 stddev:1510.96 (26.3%) stddev-sans-first:1472.74 01:38:21 INFO - PROCESS | 1892 | Values: 356.6 361.7 366.8 367.6 371.7 5875.0 5901.6 5921.0 5921.4 5938.0 5445.9 5718.8 5789.9 5793.9 5824.8 4482.5 4484.6 4497.4 4504.9 4523.2 4500.7 4506.3 4522.1 4536.6 4537.2 4405.4 4455.1 4486.1 4515.6 4527.9 4415.4 4439.6 4440.5 4445.4 4465.9 3883.0 3915.0 3917.2 3940.0 3955.7 5617.4 5647.8 5648.5 5667.6 5711.9 4886.8 5163.9 5174.4 5190.7 5197.6 6037.2 6097.0 6125.9 6153.3 6180.2 4127.6 4380.5 4387.3 4393.7 4415.9 6081.3 6222.3 6333.3 6380.4 6392.8 4364.8 4382.7 4417.3 4422.5 4442.3 4407.3 4478.4 4482.4 4484.8 4510.8 4885.3 5095.7 5160.8 5182.8 5194.5 6098.7 6106.5 6112.9 6116.4 6138.2 1547.3 1562.9 1568.2 1569.7 1570.0 953.5 984.8 994.3 999.7 1005.8 5260.7 5262.2 5317.8 5324.9 5383.3 5527.0 5552.8 5555.7 5634.9 5696.2 5194.8 5304.5 5503.5 5971.2 5985.9 3318.4 3369.0 3372.6 3375.7 3377.8 6296.9 6505.5 6529.2 6553.5 6571.2 6467.9 6491.0 6520.6 6521.0 6565.0 6282.9 6472.2 6541.4 6542.2 6563.8 6235.8 6289.4 6328.9 6394.4 6397.2 5950.6 6267.2 6289.2 6292.0 6324.1 6347.6 6473.4 6474.3 6538.6 6543.1 4461.1 4461.6 4463.1 4473.9 4494.7 6071.3 6278.7 6307.9 6331.3 6331.4 6093.3 6133.2 6136.4 6147.4 6152.0 5837.5 6018.7 6062.5 6098.6 6099.8 5987.8 6009.4 6018.0 6019.4 6048.2 6073.7 6112.6 6181.0 6192.6 6204.6 5759.8 5992.9 6038.4 6043.6 6052.0 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - PROCESS | 1892 | [#5] yui.html Cycles:180 Average:21042.38 Median:3993.72 stddev:29289.16 (733.4%) stddev-sans-first:29332.00 01:38:21 INFO - PROCESS | 1892 | Values: 831.1 836.9 877.0 899.0 925.2 17369.0 18421.4 18458.4 18472.7 18501.9 16739.7 16951.0 17044.7 17229.6 17652.4 843.1 844.8 846.5 847.5 849.5 813.7 822.4 822.9 824.3 828.2 915.5 918.4 918.6 919.2 920.8 900.1 905.0 905.1 907.0 908.0 652.8 654.2 658.9 659.2 660.3 14221.9 14672.4 14718.8 14742.7 14841.6 15285.8 15465.2 15555.8 15858.3 15872.1 12216.6 12445.2 12514.2 12527.2 12706.3 3959.3 3977.1 4010.4 4022.2 4163.0 69581.7 73277.6 73709.6 77451.6 84627.6 11150.3 11424.9 11693.9 11727.2 12335.9 22668.5 22973.0 23066.0 23067.7 23168.1 9395.2 9435.3 9451.9 9551.2 9556.4 5105.6 5147.8 5226.1 5272.5 5434.5 3799.7 3858.3 3901.2 3902.2 3902.6 665.7 682.2 683.6 694.3 707.2 672.6 820.6 827.5 833.4 838.3 10328.8 10383.4 10759.4 10779.1 10975.0 698.6 745.2 798.6 814.8 819.1 5039.3 5050.2 5064.3 5121.1 5311.2 99181.0 100270.0 102325.0 113515.0 119177.4 95625.0 96051.0 96170.0 96413.0 97596.5 85265.0 87053.6 89533.6 90238.0 92431.0 9960.4 10421.7 10622.6 10841.8 10858.2 39041.8 42402.2 47085.3 49319.3 52323.5 79271.0 79994.0 80320.6 81137.0 81545.8 14133.6 14192.2 14237.4 14349.9 14522.4 13280.8 13583.7 13621.8 13723.7 13760.7 14180.9 14832.5 14902.6 14925.8 14927.2 13361.1 13364.7 13722.4 13767.8 13873.1 13612.5 13819.7 14481.9 14716.5 14811.9 10863.5 10998.2 11728.5 12058.9 12320.3 11365.2 12109.8 12141.4 12191.2 12444.6 01:38:21 INFO - PROCESS | 1892 | -------- Summary: end -------- 01:38:21 INFO - PROCESS | 1892 | 01:38:21 INFO - TEST-INFO | 1892: exit 0 01:38:21 INFO - TEST-OK | dromaeo_css | took 1113279ms 01:38:21 INFO - TEST-START | kraken 01:38:21 INFO - operating with platform_type : linux_ 01:38:21 INFO - Initialising browser for kraken test... 01:38:21 INFO - TEST-INFO | started process 2139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPTBis/profile http://localhost:60185/getInfo.html) 01:38:27 INFO - PROCESS | 2139 | __metrics Screen width/height:1600/1200 01:38:27 INFO - PROCESS | 2139 | colorDepth:24 01:38:27 INFO - PROCESS | 2139 | Browser inner width/height: 1024/697 01:38:27 INFO - PROCESS | 2139 | __metrics 01:38:27 ERROR - PROCESS | 2139 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:38:28 INFO - TEST-INFO | 2139: exit 0 01:38:28 INFO - Browser initialized. 01:38:28 INFO - Running cycle 1/1 for kraken test... 01:38:28 INFO - TEST-INFO | started process 2271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPTBis/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:40 INFO - PROCESS | 2271 | RSS: Main: 156127232 01:38:40 INFO - PROCESS | 2271 | 01:38:43 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60185/tests/kraken/driver.html?testName=audio-beat-detection) 01:38:43 INFO - PROCESS | 2271 | RSS: Main: 161095680 01:38:43 INFO - PROCESS | 2271 | 01:38:46 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60185/tests/kraken/driver.html?testName=audio-dft) 01:38:47 INFO - PROCESS | 2271 | RSS: Main: 160497664 01:38:47 INFO - PROCESS | 2271 | 01:38:50 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60185/tests/kraken/driver.html?testName=audio-fft) 01:38:50 INFO - PROCESS | 2271 | RSS: Main: 160980992 01:38:50 INFO - PROCESS | 2271 | 01:38:52 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60185/tests/kraken/driver.html?testName=audio-oscillator) 01:38:53 INFO - PROCESS | 2271 | RSS: Main: 160878592 01:38:53 INFO - PROCESS | 2271 | 01:38:55 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:38:56 INFO - PROCESS | 2271 | RSS: Main: 160628736 01:38:56 INFO - PROCESS | 2271 | 01:38:59 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60185/tests/kraken/driver.html?testName=imaging-darkroom) 01:38:59 INFO - PROCESS | 2271 | RSS: Main: 160403456 01:38:59 INFO - PROCESS | 2271 | 01:39:03 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60185/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:03 INFO - PROCESS | 2271 | RSS: Main: 161038336 01:39:03 INFO - PROCESS | 2271 | 01:39:06 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60185/tests/kraken/driver.html?testName=json-parse-financial) 01:39:07 INFO - PROCESS | 2271 | RSS: Main: 160899072 01:39:07 INFO - PROCESS | 2271 | 01:39:08 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:39:09 INFO - PROCESS | 2271 | RSS: Main: 160641024 01:39:09 INFO - PROCESS | 2271 | 01:39:11 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:39:11 INFO - PROCESS | 2271 | RSS: Main: 160694272 01:39:11 INFO - PROCESS | 2271 | 01:39:13 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:39:14 INFO - PROCESS | 2271 | RSS: Main: 160718848 01:39:14 INFO - PROCESS | 2271 | 01:39:17 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:17 INFO - PROCESS | 2271 | RSS: Main: 161353728 01:39:17 INFO - PROCESS | 2271 | 01:39:20 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:21 INFO - PROCESS | 2271 | RSS: Main: 161288192 01:39:21 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | Cycle 1(1): loaded http://localhost:60185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60185/tests/kraken/driver.html?testName=ai-astar) 01:39:22 INFO - PROCESS | 2271 | RSS: Main: 161824768 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | __start_tp_report 01:39:22 INFO - PROCESS | 2271 | _x_x_mozilla_page_load 01:39:22 INFO - PROCESS | 2271 | _x_x_mozilla_page_load_details 01:39:22 INFO - PROCESS | 2271 | |i|pagename|runs| 01:39:22 INFO - PROCESS | 2271 | |0;ai-astar;113;104;111;109;111;113;113;108;110;109 01:39:22 INFO - PROCESS | 2271 | |1;audio-beat-detection;147;125;151;176;126;152;154;135;191;132 01:39:22 INFO - PROCESS | 2271 | |2;audio-dft;162;162;163;163;161;163;162;163;165;160 01:39:22 INFO - PROCESS | 2271 | |3;audio-fft;74;75;75;179;76;75;75;74;162;75 01:39:22 INFO - PROCESS | 2271 | |4;audio-oscillator;84;84;150;86;85;85;136;85;84;142 01:39:22 INFO - PROCESS | 2271 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;118;117 01:39:22 INFO - PROCESS | 2271 | |6;imaging-darkroom;148;148;147;147;147;148;149;147;146;148 01:39:22 INFO - PROCESS | 2271 | |7;imaging-desaturate;96;95;97;95;95;96;96;96;95;96 01:39:22 INFO - PROCESS | 2271 | |8;json-parse-financial;50;60;52;54;52;58;53;52;53;51 01:39:22 INFO - PROCESS | 2271 | |9;json-stringify-tinderbox;59;60;59;59;61;60;60;60;65;61 01:39:22 INFO - PROCESS | 2271 | |10;stanford-crypto-aes;77;75;76;77;79;77;78;76;107;79 01:39:22 INFO - PROCESS | 2271 | |11;stanford-crypto-ccm;120;136;127;134;121;134;126;127;135;132 01:39:22 INFO - PROCESS | 2271 | |12;stanford-crypto-pbkdf2;160;161;156;151;157;152;156;156;153;152 01:39:22 INFO - PROCESS | 2271 | |13;stanford-crypto-sha256-iterative;68;63;62;62;66;63;60;65;64;61 01:39:22 INFO - PROCESS | 2271 | __end_tp_report 01:39:22 INFO - PROCESS | 2271 | __start_cc_report 01:39:22 INFO - PROCESS | 2271 | _x_x_mozilla_cycle_collect,885 01:39:22 INFO - PROCESS | 2271 | __end_cc_report 01:39:22 INFO - PROCESS | 2271 | __startTimestamp1467103162965__endTimestamp 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | ------- Summary: start ------- 01:39:22 INFO - PROCESS | 2271 | Number of tests: 14 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.81 (2.5%) stddev-sans-first:2.77 01:39:22 INFO - PROCESS | 2271 | Values: 113.0 104.0 111.0 109.0 111.0 113.0 113.0 108.0 110.0 109.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:151.50 stddev:21.41 (14.1%) stddev-sans-first:22.70 01:39:22 INFO - PROCESS | 2271 | Values: 147.0 125.0 151.0 176.0 126.0 152.0 154.0 135.0 191.0 132.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 01:39:22 INFO - PROCESS | 2271 | Values: 162.0 162.0 163.0 163.0 161.0 163.0 162.0 163.0 165.0 160.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:40.52 (54.0%) stddev-sans-first:42.33 01:39:22 INFO - PROCESS | 2271 | Values: 74.0 75.0 75.0 179.0 76.0 75.0 75.0 74.0 162.0 75.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:84.50 stddev:28.20 (33.4%) stddev-sans-first:29.14 01:39:22 INFO - PROCESS | 2271 | Values: 84.0 84.0 150.0 86.0 85.0 85.0 136.0 85.0 84.0 142.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:39:22 INFO - PROCESS | 2271 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 01:39:22 INFO - PROCESS | 2271 | Values: 148.0 148.0 147.0 147.0 147.0 148.0 149.0 147.0 146.0 148.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:39:22 INFO - PROCESS | 2271 | Values: 96.0 95.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:3.14 (5.9%) stddev-sans-first:3.06 01:39:22 INFO - PROCESS | 2271 | Values: 50.0 60.0 52.0 54.0 52.0 58.0 53.0 52.0 53.0 51.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.78 (3.0%) stddev-sans-first:1.81 01:39:22 INFO - PROCESS | 2271 | Values: 59.0 60.0 59.0 59.0 61.0 60.0 60.0 60.0 65.0 61.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:77.00 stddev:9.54 (12.4%) stddev-sans-first:10.05 01:39:22 INFO - PROCESS | 2271 | Values: 77.0 75.0 76.0 77.0 79.0 77.0 78.0 76.0 107.0 79.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:133.00 stddev:5.83 (4.4%) stddev-sans-first:5.14 01:39:22 INFO - PROCESS | 2271 | Values: 120.0 136.0 127.0 134.0 121.0 134.0 126.0 127.0 135.0 132.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:3.41 (2.2%) stddev-sans-first:3.18 01:39:22 INFO - PROCESS | 2271 | Values: 160.0 161.0 156.0 151.0 157.0 152.0 156.0 156.0 153.0 152.0 01:39:22 INFO - PROCESS | 2271 | 01:39:22 INFO - PROCESS | 2271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.41 (3.8%) stddev-sans-first:1.90 01:39:22 INFO - PROCESS | 2271 | Values: 68.0 63.0 62.0 62.0 66.0 63.0 60.0 65.0 64.0 61.0 01:39:22 INFO - PROCESS | 2271 | -------- Summary: end -------- 01:39:22 INFO - PROCESS | 2271 | 01:39:23 INFO - TEST-INFO | 2271: exit 0 01:39:23 INFO - TEST-OK | kraken | took 61993ms 01:39:23 INFO - SUITE-END | took 1175s 01:39:24 INFO - Completed test suite (00:19:35) 01:39:24 INFO - javascript benchmark 01:39:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7748.834560961375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.043507817811, 3477.37407266692, 3480.5649293838287, 3495.3358861816255, 3505.456654218597, 5811.535077193825, 5848.005839007363, 5868.911966320503, 5902.970485147568, 5936.88126237475, 5882.911756323659, 5911.586188966774, 5912.083627037805, 5928.347881733006, 5931.88136237275, 5252.947470525303, 5337.0, 5396.271503347057, 5402.216678581623, 5405.081136206854, 5254.737263136847, 5259.079661059319, 5307.65500242483, 5390.299261096052, 5405.162199859008, 5255.658382205163, 5258.947410525903, 5261.868453288679, 5283.101872681634, 5302.390225124122, 5235.293235413227, 5286.07493688603, 5317.601179911522, 5324.094903866352, 5344.0, 5132.127538318495, 5138.897222055575, 5212.348456442945, 5243.213517972296, 5299.947000530023, 5678.943210567924, 5756.136579513065, 5790.7104644768015, 5804.071348584206, 5810.33181184165, 6342.968285158545, 6363.7772677956045, 6370.140031095835, 6377.330380310047, 6389.233292004943, 6114.054067497291, 6135.754569817202, 6136.3965394158, 6398.968005159991, 6414.647194404306, 5819.359870414251, 5821.563382746311, 5830.854228644275, 5836.562257830679, 5855.063189889597, 6336.334684858116, 6370.044493326038, 6376.426121649074, 6388.393102655334, 6391.3289104643345, 5993.520518358521, 6085.056816193409, 6096.237970253718, 6099.634021958696, 6121.84695382619, 6212.502999760099, 6265.122882796412, 6271.749130034838, 6277.96861015692, 6278.340774218733, 6136.355682653347, 6250.9062364064575, 6260.655663938436, 6262.091996660459, 6269.0, 6058.878822423527, 6203.937960620427, 6214.502839772807, 6251.78118765841, 6373.74505019794, 4796.592289655348, 4798.23228283473, 4805.423349198119, 4812.975935120302, 4828.7102773833685, 4151.398047283127, 4251.59609837065, 4284.121755040209, 4285.142971405731, 4328.026194106364, 5847.415258474203, 5903.291605007426, 5927.555433342516, 5945.2865656120675, 5970.104484327386, 6217.036359364306, 6223.941929871932, 6314.842128946813, 6325.810225693236, 6343.5876668016435, 5895.616784908967, 6016.518678505709, 6020.8795824084145, 6026.306974697965, 6032.728527216286, 5322.654027488201, 5344.545713614386, 5360.865978350573, 5376.731163441812, 5425.294711687456, 6489.545731798823, 6545.050967609765, 6546.116274302908, 6555.3772391622715, 6560.245571759213, 6041.2750469943885, 6259.593126446766, 6338.714757836001, 6362.204724409449, 6362.968185159045, 6449.580777249464, 6579.407853293226, 6579.934200657932, 6590.340965903371, 6593.571417858016, 6275.027370757357, 6282.434580887742, 6284.3087260402235, 6286.905696414649, 6310.52671049664, 6141.232345956755, 6232.875342493216, 6251.062340648939, 6414.166158399378, 6423.42189202974, 6188.133661287334, 6188.2883468399905, 6210.4100110489435, 6238.937610624017, 6241.625502469685, 6215.595986260879, 6218.160548325918, 6233.470155036873, 6233.625982441068, 6244.375562443719, 5839.649621022752, 5966.701664916824, 5973.761049557969, 6014.57897947157, 6077.453029227391, 6188.226471691039, 6196.597221180609, 6228.252609686867, 6236.844078898064, 6247.437730604267, 6068.787592434243, 6081.6351018939, 6091.451769340781, 6097.939020609737, 6104.20971395849], "value": 5786.041440689418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8780156167205, 631.3497097989072, 638.9169407976963, 649.4706813946631, 658.2298710508705, 47269.0, 48683.999999999956, 48736.51263487364, 51600.0, 51687.22469162966, 48549.51450485494, 48787.75606121965, 48921.26618100731, 49134.75432622832, 49243.26135107967, 9200.53997300134, 9351.812963740722, 9357.625694972194, 9361.391509551857, 9372.297077719164, 9142.771430714252, 9157.771055723593, 9238.076192380742, 9238.30712696547, 9250.67622633208, 9232.169104780569, 9254.86117708235, 9294.628214871396, 9299.209567186797, 9299.349045566812, 9229.861552076723, 9261.120193581599, 9276.90723092774, 9279.257659387233, 9295.024022477677, 9075.954620226923, 9165.908340916572, 9167.12912273333, 9171.816563668755, 9181.0, 45434.54565454369, 45490.54509454929, 45915.311270330974, 45980.54019459796, 45997.310040349425, 3997.5402828674783, 4067.8983025424304, 4103.610157035107, 4239.342901850218, 4492.707973981714, 34907.82546087279, 35077.82461087704, 35428.114297142776, 35707.28585428303, 35900.28199436023, 4683.953160468386, 4730.266808644666, 4758.262469317261, 4788.976055119702, 4803.471618122004, 400146.0, 400525.0, 400991.0, 401351.9999999971, 401483.0, 38516.42225366622, 66267.66866165638, 66853.0, 66896.0, 66947.0, 40970.0, 41103.0, 41189.38215926763, 41242.79378603088, 41341.79329103395, 17680.381186658404, 18039.458816235532, 18045.7293140603, 18057.09714514269, 18076.72884906701, 14655.780163297559, 14716.852831471762, 14826.110433373817, 14862.777058344134, 14892.553223403314, 9170.541472926461, 9207.861882071775, 9220.170184683411, 9272.953635231781, 9311.115444032806, 3414.7438942079443, 3521.1901262709207, 3546.280054173724, 3568.6966607838103, 3623.7463377563845, 1117.586492997596, 1124.16249893828, 1142.868570114431, 1183.6094088950626, 1264.6964728465102, 35116.64883351185, 35256.82371588177, 35309.823450882584, 35681.28637427237, 35823.82088089595, 1144.6909334479644, 1189.29831399473, 1221.8961388282096, 1266.3541593787236, 1278.5013844600612, 17944.641107178046, 18106.728399074025, 18181.81818181828, 18198.272069117353, 18357.3574924877, 714082.0, 714343.0, 725143.0, 965513.0, 1044171.0, 68934.0, 68947.31052689509, 69158.0, 69462.0, 69491.0, 1503.4737841755298, 1506.758918573023, 1507.5854140111337, 1512.1834209526953, 1522.91623960681, 34852.825735871156, 35207.82396088003, 35419.64580354266, 35482.822585886905, 35485.82257088698, 58977.11534327074, 59407.0, 59504.0, 59826.70086649539, 59984.700076499335, 582384.0, 584140.0, 584823.0, 585821.0, 586961.0, 32149.839250803598, 32569.511457327684, 32707.836460817543, 33038.5044224332, 33191.33617327688, 54312.18531721948, 55178.44821551733, 55452.0, 56125.438745612024, 56419.43580564142, 45694.31458528058, 45883.770581146884, 46390.30414543717, 46600.53399465962, 47100.0, 45225.60440437314, 45660.086798264514, 45690.0, 46197.0, 47530.52469475399, 45502.0, 46516.53483465122, 46777.76611116923, 46928.0, 47034.059318812746, 38746.41880371853, 40138.79930600328, 40608.390874137505, 40803.1839363217, 41444.79277603713, 30372.24069398283, 30823.2294192638, 31036.0, 31236.687633124286, 31299.217519562193], "value": 21285.684045780534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.72801135284766, 434.30077575104076, 439.2364803703833, 439.44849214236126, 444.1272898753948, 18878.716819247704, 19814.90092549537, 20750.377488675345, 20907.268245611405, 20967.0, 19097.23611055556, 19570.902145489254, 20329.28847490338, 20408.693869591967, 20441.0, 5824.650520968745, 5985.940140598582, 6022.2773267207995, 6023.759049638009, 6048.788292409767, 5754.913676294838, 5924.259467566554, 5945.197398351233, 5972.731227094791, 5994.490468310199, 5886.352501224862, 5899.174115623816, 5902.675352855591, 5906.527477801766, 5917.260342457193, 5659.886802263953, 5873.412658734135, 5884.852878678067, 5909.231799866033, 5910.88178236435, 5316.38861530925, 5331.653442526263, 5340.49265319794, 5342.973285133588, 5363.034653762321, 15200.087994720241, 16126.0, 21623.135074596998, 22735.54528909429, 22769.203077892194, 2307.411610039446, 2376.239603326936, 2475.356407334088, 2522.6089956056658, 2574.742525747429, 10414.583416663325, 10714.250002499828, 11234.719132021683, 11604.477798499087, 15623.218839058001, 2020.7575090989028, 2030.5938812237464, 2041.101915157326, 2080.6566916458764, 2115.5663089066707, 86564.56717716371, 86726.56636716839, 86952.0, 86962.56518717366, 88381.11618883793, 11943.701407464883, 12223.0, 12291.56979505713, 12379.257244565355, 13096.279704616338, 16725.498235052968, 16922.069286189377, 16956.321747130223, 17009.0, 17026.31894724222, 8853.601587928559, 9072.092790720875, 9147.954260228656, 9256.935452422922, 9339.206167475704, 8819.911800882037, 8846.690365837165, 8860.822783544292, 8912.68805591814, 9146.451212927246, 5031.421386540522, 5071.670341427795, 5215.634905556651, 5330.493603107699, 5352.2506849041165, 2125.4048866317457, 2135.6689713094183, 2194.7585765566096, 2210.728830922194, 2239.2386588559966, 985.4678473624306, 1010.7523656704154, 1079.6760971708457, 1081.8918108189275, 1102.3385968418884, 19839.404817855488, 19915.0, 20385.592288154156, 20493.0, 20497.38507844767, 1058.5342449322427, 1059.4914441068331, 1074.2372915230274, 1091.6179337232063, 1103.3710784852558, 10935.234533582572, 11316.886831131584, 11356.432178391213, 11533.192676512563, 11564.768704626029, 529206.0, 595100.0, 595108.0, 597597.0, 631196.0, 104905.0, 107989.46005269923, 111683.44158279157, 112264.0, 113021.43489282501, 533.3067012883237, 551.0246863052455, 552.1414200917611, 553.8975289571442, 554.3043480432032, 11470.311781293149, 12090.395480226129, 12386.256824590553, 12483.625491235278, 12509.124361294622, 43758.343624845016, 44801.55198448104, 45328.32007519956, 45662.77168614269, 48194.0, 62965.68517157385, 63262.0, 63496.0, 64705.67647161734, 65239.673801630684, 9282.118198771106, 9427.528623568656, 9462.858057129286, 9493.335466517277, 9663.613455461702, 13180.802287965496, 14116.78824817608, 14165.575032749033, 14203.928980355033, 14251.287435628385, 12365.319907405179, 12373.690657733629, 12418.316992565135, 12543.24740515572, 12609.747805043664, 9077.727668169966, 11885.702857428634, 12203.877961220629, 12442.129050966345, 12567.245965242115, 12467.251964882136, 12563.371831408576, 12609.30648814324, 12634.115611907078, 12771.489140434278, 9338.719838404859, 9377.156055954996, 9396.67111651089, 9548.713538593853, 9659.613615455302, 9931.801363972536, 12551.184173028723, 12574.434150463434, 12835.42240599194, 12901.290429026494], "value": 9578.858513293228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.0, 1607.7347237705778, 1827.552249698824, 1921.4235729281213, 1929.3922414439442, 9277.211437027852, 9850.507474626267, 9858.359206651563, 9887.950560247189, 9985.450800205987, 10351.275410721253, 10368.06687398134, 10397.532111055001, 10495.73760655982, 10496.580136794519, 2582.65134206882, 2616.6336712860216, 2621.9344516387146, 2627.6189952456884, 2628.2640860559072, 2522.054229663876, 2563.4873025394904, 2566.2429583272888, 2566.6278389633494, 2570.755778201077, 2545.7836083932793, 2552.8595927223996, 2573.0608327960254, 2574.9227523174336, 2581.0063125696556, 2511.359603301156, 2524.5203411351786, 2537.9873100634563, 2561.3468565515673, 2569.7687208151356, 2445.9877700611382, 2476.3932836455006, 2489.103922587885, 2517.886695098725, 2533.67062281904, 9731.610735570568, 9817.607295708163, 9817.656382026595, 9828.21374290055, 9849.0, 5775.826725198251, 5788.82633520995, 5811.27359080115, 5814.186013958049, 5975.671338076404, 3535.7524973251884, 3676.4117741161285, 3707.0, 3712.053426376284, 3742.5883152853166, 1133.1557989297944, 1146.6273461125168, 1154.832549280358, 1157.5254145800182, 1177.911656625748, 13909.165450072927, 13914.582562523141, 14004.859951400458, 14017.579472615736, 14108.365123569361, 5004.099262132851, 5090.185570308733, 5112.309838171799, 5149.588032957355, 5178.223266510054, 10638.840417393745, 10646.041856232976, 10646.627368042082, 10746.247762656696, 10758.193135514868, 5625.296837895263, 5632.295963004624, 5681.9431805681415, 5691.857703557444, 5692.48767610917, 4809.9038019239415, 5261.263423120766, 5272.0, 5391.029614669397, 5392.514673679388, 4245.724027938236, 4271.850485233002, 4325.545817689097, 4358.476982762026, 4394.736315821061, 1242.4098553187164, 1294.4951468927127, 1296.857345691973, 1305.2299143505377, 1309.646395473217, 876.5354362188051, 948.7675519497767, 969.6557722008727, 970.8058388322364, 980.6273616025865, 6241.937580624226, 6258.499320054385, 6266.122742816009, 6294.3076261612105, 6353.841153971188, 493.14685593921996, 495.7422140486927, 505.8634168774484, 508.3569284854662, 517.0434695812717, 4348.369486424451, 4350.891227719269, 4395.1868904252815, 4396.692231543825, 4410.448693913261, 12435.502579896884, 12813.807792883114, 12819.1026628137, 12845.935770321088, 12908.419121139383, 12420.254784712946, 12685.048621353435, 12703.364831758376, 12716.300603466712, 12765.680857978625, 9313.161815436642, 9336.9262534808, 9380.061993800702, 9388.295877809192, 9416.152546270869, 6274.498040156868, 6305.905411418924, 6362.0, 6405.135306733718, 6415.422611964946, 10684.09185219234, 11623.476943537393, 11653.592124275949, 11848.0, 11920.52317907274, 11175.776484470103, 11322.094232461219, 11332.716682083013, 11372.488238029144, 11468.82796758066, 8488.448250863674, 8862.822743544964, 8951.373403861668, 9066.773330666521, 9087.36388452802, 9322.067793220624, 9364.719058428258, 9410.247180225702, 9451.149396554343, 9455.0, 8440.324774017941, 8475.194856488624, 8595.140485951355, 8636.222739953435, 8656.78358041054, 7726.9227307726205, 7771.494852834548, 8169.754907352789, 8216.876746848682, 8257.21556452136, 7355.190928997699, 7364.153122390993, 7366.079240094989, 7366.189719130998, 7366.373858222111, 5477.068898287381, 5477.397486276427, 5568.832935011957, 5595.440455954372, 5619.2133101365025, 5280.128778751463, 5309.389420216725, 5416.729163541886, 5505.449455054462, 5551.639143455663], "value": 4980.756158616603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.61663711510124, 361.69075440498375, 366.8165917041479, 367.6433859156617, 371.71192325947385, 5875.0, 5901.557383196256, 5920.963831329522, 5921.378255283193, 5937.970310148454, 5445.863853403657, 5718.799052199043, 5789.855253618662, 5793.884122317551, 5824.835032993397, 4482.462104547442, 4484.59638632523, 4497.437820272466, 4504.932426013613, 4523.208438523262, 4500.672301671015, 4506.324051392301, 4522.09558088382, 4536.56902594253, 4537.183307004738, 4405.405270288518, 4455.086707225028, 4486.147631949935, 4515.593596576307, 4527.932081018771, 4415.381846541487, 4439.622632076277, 4440.4893437254805, 4445.444319460067, 4465.866024019285, 3882.951603067156, 3914.9608503914883, 3917.158935300404, 3940.0, 3955.7033222508426, 5617.38208797032, 5647.830565083054, 5648.548116150698, 5667.603267771257, 5711.886182194474, 4886.780094895738, 5163.927463159414, 5174.379074511083, 5190.688558686453, 5197.58419326453, 6037.245344331958, 6096.969515152396, 6125.908111378333, 6153.261608606996, 6180.218901494301, 4127.587241275878, 4380.532521605266, 4387.254166791653, 4393.736375817429, 4415.911681766379, 6081.331053584102, 6222.284437289679, 6333.303336632966, 6380.425761681471, 6392.808215753488, 4364.8254069837485, 4382.69321147523, 4417.337399390053, 4422.474246384992, 4442.311441726538, 4407.338899165151, 4478.350639157369, 4482.417285752831, 4484.798184081724, 4510.819567217341, 4885.291632713237, 5095.719735414514, 5160.7935682573025, 5182.792688292501, 5194.454582268883, 6098.72555734993, 6106.45041946218, 6112.908306375408, 6116.388361163937, 6138.232720909887, 1547.2959803289477, 1562.9140397278031, 1568.239403889113, 1569.6625225576556, 1570.0, 953.5327689432129, 984.7981163861391, 994.3238597753452, 999.7403271877487, 1005.7930483419925, 5260.684358938476, 5262.236975638511, 5317.760700768475, 5324.893502129936, 5383.308345827087, 5527.0, 5552.7778888844805, 5555.749991250404, 5634.85912852182, 5696.23100881384, 5194.818181363634, 5304.469553044664, 5503.504684578407, 5971.164037034819, 5985.940140598538, 3318.402687516222, 3368.983155084209, 3372.6121496028272, 3375.6624337566536, 3377.763556551067, 6296.866564018429, 6505.4795616350575, 6529.249136349285, 6553.475721942234, 6571.244306904671, 6467.870642587122, 6491.0, 6520.576162549419, 6521.0, 6564.967175164189, 6282.937170628326, 6472.190976127984, 6541.443977261891, 6542.182227221598, 6563.803085907431, 6235.750569977332, 6289.433950944437, 6328.936710632835, 6394.392532709385, 6397.168368112116, 5950.553708471795, 6267.2165979252595, 6289.182406287337, 6291.96854015727, 6324.1146239527425, 6347.636247371149, 6473.385028422293, 6474.320196379313, 6538.607683539003, 6543.149390579194, 4461.13007963444, 4461.598456138963, 4463.085067561207, 4473.852550775711, 4494.6629002825575, 6071.332153463027, 6278.686065696788, 6307.936920630735, 6331.303556608677, 6331.398517140864, 6093.268807743099, 6133.202683651275, 6136.355682653257, 6147.415995480422, 6151.96924015377, 5837.503812176013, 6018.699065046818, 6062.514998799998, 6098.603590766586, 6099.817005489843, 5987.7604895805425, 6009.429104235091, 6018.0, 6019.367966363468, 6048.153258543895, 6073.726682299219, 6112.572119951738, 6180.969095154675, 6192.59748116389, 6204.565680402328, 5759.798407055733, 5992.850178745566, 6038.426349496791, 6043.640180959249, 6052.0], "value": 4613.684586934925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.1356189562855, 836.8912041434612, 876.9912300876991, 899.0380293086392, 925.2459245714742, 17369.0, 18421.447356579323, 18458.446246612606, 18472.722909156375, 18501.907490462545, 16739.66520669586, 16951.0, 17044.744328835077, 17229.569260768487, 17652.38216662417, 843.1105184030845, 844.7676888855552, 846.5047946951041, 847.516915358246, 849.524266410812, 813.6704634622987, 822.3873214455239, 822.880682301066, 824.3116997307255, 828.1801016993163, 915.4690279637794, 918.4305730447132, 918.6325469812095, 919.2278486071698, 920.7513971227764, 900.131373224838, 905.0180554098778, 905.0723008915849, 906.9863952040724, 908.0329449136682, 652.8465810534568, 654.1757385694012, 658.8912829383146, 659.1859054068221, 660.3099760750027, 14221.857781422157, 14672.413103475848, 14718.779218311734, 14742.70514589713, 14841.554753357417, 15285.847141528553, 15465.226738663134, 15555.766663500057, 15858.286377113058, 15872.12703301318, 12216.633500994983, 12445.191062580903, 12514.18657787241, 12527.18573292733, 12706.301153436558, 3959.287328280937, 3977.065389633434, 4010.3783913493453, 4022.1955608878343, 4163.042500224935, 69581.65209173973, 73277.6336118316, 73709.63145184293, 77451.6127419365, 84627.57686211653, 11150.330980141218, 11424.885751142383, 11693.88306116945, 11727.237729547724, 12335.938320308342, 22668.546629067325, 22973.0, 23066.0, 23067.653985190234, 23168.073277069067, 9395.154436100784, 9435.292353073546, 9451.905480945241, 9551.235901127893, 9556.426614403159, 5105.566026887756, 5147.794088236504, 5226.137687281632, 5272.499112584298, 5434.456554344534, 3799.7340186187253, 3858.3247931611854, 3901.2197560488016, 3902.180542086137, 3902.551206611276, 665.7203974330793, 682.2052309059989, 683.5625199872086, 694.3160986428364, 707.2291202589203, 672.5863593889723, 820.5733018830175, 827.5241736001823, 833.4291010657598, 838.3251334036902, 10328.793424131476, 10383.428911409945, 10759.3544387337, 10779.137668986463, 10975.0, 698.6262349642917, 745.2175216023262, 798.604690678118, 814.8207394373228, 819.0949001353538, 5039.294498770175, 5050.242463630411, 5064.316317297192, 5121.052605268037, 5311.150215965427, 99181.0, 100270.0, 102325.0, 113515.0, 119177.40411297888, 95625.0, 96051.0, 96170.0, 96413.0, 97596.51201744088, 85265.0, 87053.56473217593, 89533.55233223923, 90237.99999999869, 92431.0, 9960.352577082467, 10421.68734937953, 10622.575096996034, 10841.837372439577, 10858.2399232053, 39041.80479097586, 42402.15195696131, 47085.293720594906, 49319.260211096145, 52323.47676523186, 79271.0, 79994.0, 80320.59839700763, 81137.0, 81545.77681334903, 14133.646658833612, 14192.219427931563, 14237.359318830884, 14349.856501434851, 14522.419103235752, 13280.80078798838, 13583.660408489472, 13621.795673064713, 13723.656908577366, 13760.65598360049, 14180.929095354457, 14832.492885316118, 14902.552923412315, 14925.776113358526, 14927.179005154821, 13361.13152645075, 13364.665883352995, 13722.382492787649, 13767.793483097561, 13873.098248613807, 13612.523561675294, 13819.654508636962, 14481.913856461018, 14716.484923027643, 14811.851881481047, 10863.456827158452, 10998.230123891251, 11728.472218750007, 12058.879411205775, 12320.260784352968, 11365.204435689422, 12109.816839640594, 12141.392930353624, 12191.207571507824, 12444.564440244549], "value": 7984.5787914217335, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 111.0, 109.0, 111.0, 113.0, 113.0, 108.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 151.0, 176.0, 126.0, 152.0, 154.0, 135.0, 191.0, 132.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 163.0, 165.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 179.0, 76.0, 75.0, 75.0, 74.0, 162.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 150.0, 86.0, 85.0, 85.0, 136.0, 85.0, 84.0, 142.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 60.0, 52.0, 54.0, 52.0, 58.0, 53.0, 52.0, 53.0, 51.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 65.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 77.0, 79.0, 77.0, 78.0, 76.0, 107.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 136.0, 127.0, 134.0, 121.0, 134.0, 126.0, 127.0, 135.0, 132.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 156.0, 151.0, 157.0, 152.0, 156.0, 156.0, 153.0, 152.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 62.0, 62.0, 66.0, 63.0, 60.0, 65.0, 64.0, 61.0], "value": 63.4, "unit": "score"}]}]} 01:39:24 INFO - Return code: 0 01:39:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:24 ERROR - # TBPL SUCCESS # 01:39:24 INFO - Running post-action listener: _resource_record_post_action 01:39:24 INFO - ##### 01:39:24 INFO - ##### Finished run-tests step (success) 01:39:24 INFO - ##### 01:39:24 INFO - Running post-run listener: _resource_record_post_run 01:39:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 270336; Write bytes: 398094336; Read time: 564; Write time: 939524 01:39:24 INFO - TinderboxPrint: CPU usage
13.5% 01:39:24 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 564 01:39:24 INFO - TinderboxPrint: I/O write bytes / time
398,094,336 / 939,524 01:39:24 INFO - TinderboxPrint: CPU idle
8,233.2 (86.5%) 01:39:24 INFO - TinderboxPrint: CPU user
1,213.8 (12.8%) 01:39:24 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:24 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 124055552; Read time: 0; Write time: 401288 01:39:24 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 270336; Write bytes: 250925056; Read time: 564; Write time: 438104 01:39:24 INFO - Running post-run listener: _upload_blobber_files 01:39:24 INFO - Blob upload gear active. 01:39:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:24 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 01:39:24 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'] 01:39:24 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 01:39:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:28 INFO - (blobuploader) - INFO - Done attempting. 01:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:29 INFO - (blobuploader) - INFO - Done attempting. 01:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:30 INFO - (blobuploader) - INFO - Done attempting. 01:39:30 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:30 INFO - Return code: 0 01:39:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30eb3bafd9eff490adc5884ec614548565c62f684a8c7aac84c33017adcca23fd288eabf197910b298d54d8c54f79c2492830b090ad6abbeb41903ef54ca77be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4030b6c3c737064899643bc88c2b001d0eed32333b6d21816f384a2b62af71be26bb4091e829a1143f5fee9b1ed0a769e17f73af87c392da129083bd09aac51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f55f579bc5058049c228fb680e6de59cdae4d19b51e38bff5e401226b233cc1ee0854304a5f56bf57759186afb77df56b751ec333e288b27913478f090eba8e"} 01:39:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:30 INFO - Contents: 01:39:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30eb3bafd9eff490adc5884ec614548565c62f684a8c7aac84c33017adcca23fd288eabf197910b298d54d8c54f79c2492830b090ad6abbeb41903ef54ca77be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4030b6c3c737064899643bc88c2b001d0eed32333b6d21816f384a2b62af71be26bb4091e829a1143f5fee9b1ed0a769e17f73af87c392da129083bd09aac51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f55f579bc5058049c228fb680e6de59cdae4d19b51e38bff5e401226b233cc1ee0854304a5f56bf57759186afb77df56b751ec333e288b27913478f090eba8e"} 01:39:30 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:30 INFO - Copying logs to upload dir... 01:39:30 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.598908 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-28 01:39:30.028875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:30.032004) ========= 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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 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/30eb3bafd9eff490adc5884ec614548565c62f684a8c7aac84c33017adcca23fd288eabf197910b298d54d8c54f79c2492830b090ad6abbeb41903ef54ca77be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4030b6c3c737064899643bc88c2b001d0eed32333b6d21816f384a2b62af71be26bb4091e829a1143f5fee9b1ed0a769e17f73af87c392da129083bd09aac51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f55f579bc5058049c228fb680e6de59cdae4d19b51e38bff5e401226b233cc1ee0854304a5f56bf57759186afb77df56b751ec333e288b27913478f090eba8e"} build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/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/30eb3bafd9eff490adc5884ec614548565c62f684a8c7aac84c33017adcca23fd288eabf197910b298d54d8c54f79c2492830b090ad6abbeb41903ef54ca77be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4030b6c3c737064899643bc88c2b001d0eed32333b6d21816f384a2b62af71be26bb4091e829a1143f5fee9b1ed0a769e17f73af87c392da129083bd09aac51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f55f579bc5058049c228fb680e6de59cdae4d19b51e38bff5e401226b233cc1ee0854304a5f56bf57759186afb77df56b751ec333e288b27913478f090eba8e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:30.057874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:30.058224) ========= 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=df17445c3590ff7897617a0e00000225-1467101115.691284-1341411343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:30.142695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:30.143036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:30.143343) ========= ========= Total master_lag: 0.94 =========