builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1467101917.76 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.758811) ========= 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.759211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.759492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.693060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.698295) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:18:38-- 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% 37.8M=0s 2016-06-28 01:18:38 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150188 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.338541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.338845) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019873 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.574122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.574448) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:18:39,682 truncating revision to first 12 chars 2016-06-28 01:18:39,683 Setting DEBUG logging. 2016-06-28 01:18:39,683 attempt 1/10 2016-06-28 01:18:39,683 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,010 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692404 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.362353) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.364912) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.365295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.365577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.426091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 0 secs) (at 2016-06-28 01:18:40.426390) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 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-006', 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": 375, 01:18:41 INFO - "slavename": "talos-linux64-ix-006", 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:48 INFO - Downloaded 1361 bytes. 01:18:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:48 INFO - Using the following test package requirements: 01:18:48 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:48 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:18:48 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:18:48 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'jsshell-linux-x86_64.zip'], 01:18:48 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:18:48 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:48 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:18:48 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:18:48 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:18:48 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:18:48 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:48 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:48 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:48 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:48 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:48 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:19:09 INFO - Downloaded 24525033 bytes. 01:19:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:19:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:19:11 INFO - Return code: 0 01:19:11 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 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 - 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:19:11 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:19:11 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:19:11 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:19:11 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:19:15 INFO - Downloaded 24525033 bytes. 01:19:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:19:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:19:17 INFO - Return code: 0 01:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:17 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:19:17 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:19:17 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:19:17 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:19:17 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:19:19 INFO - Downloaded 10833369 bytes. 01:19:19 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:19:19 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:19:19 INFO - Return code: 0 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 - 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:19:19 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:19:19 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:19:19 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:19:19 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:35 INFO - Downloaded 63614591 bytes. 01:19:35 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:35 INFO - mkdir: /builds/slave/test/properties 01:19:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:35 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:35 INFO - Contents: 01:19:35 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:35 INFO - Running post-action listener: _resource_record_post_action 01:19:35 INFO - Running post-action listener: set_extra_try_arguments 01:19:35 INFO - ##### 01:19:35 INFO - ##### Finished download-and-extract step (success) 01:19:35 INFO - ##### 01:19:35 INFO - ##### 01:19:35 INFO - ##### Running populate-webroot step. 01:19:35 INFO - ##### 01:19:35 INFO - Running pre-action listener: _resource_record_pre_action 01:19:35 INFO - Running main action method: populate_webroot 01:19:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:35 INFO - '--tppagecycles', 01:19:35 INFO - '7'], 01:19:35 INFO - 'tests': ['tsvgm']}}, 01:19:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['damp', 'tps']}, 01:19:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'tests': ['damp', 'tps']}, 01:19:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['dromaeo_dom']}, 01:19:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['a11yr', 01:19:35 INFO - 'ts_paint', 01:19:35 INFO - 'tpaint', 01:19:35 INFO - 'sessionrestore', 01:19:35 INFO - 'sessionrestore_no_auto_restore', 01:19:35 INFO - 'tabpaint']}, 01:19:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['tsvgx', 01:19:35 INFO - 'tsvgr_opacity', 01:19:35 INFO - 'tart', 01:19:35 INFO - 'tscrollx', 01:19:35 INFO - 'cart']}, 01:19:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:35 INFO - 'tsvgr_opacity', 01:19:35 INFO - 'tart', 01:19:35 INFO - 'tscrollx', 01:19:35 INFO - 'cart']}, 01:19:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'talos_options': ['--disable-e10s'], 01:19:35 INFO - 'tests': ['tp5o']}, 01:19:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'tests': ['tp5o']}, 01:19:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'talos_options': ['--disable-e10s', 01:19:35 INFO - '--xperf_path', 01:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:35 INFO - 'tests': ['tp5n']}, 01:19:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:35 INFO - 'talos_options': ['--xperf_path', 01:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:35 INFO - 'tests': ['tp5n']}}, 01:19:35 INFO - 'talos.zip': {'path': '', 01:19:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:35 INFO - Running post-action listener: _resource_record_post_action 01:19:35 INFO - ##### 01:19:35 INFO - ##### Finished populate-webroot step (success) 01:19:35 INFO - ##### 01:19:35 INFO - ##### 01:19:35 INFO - ##### Running create-virtualenv step. 01:19:35 INFO - ##### 01:19:35 INFO - Running pre-action listener: _resource_record_pre_action 01:19:35 INFO - Running main action method: create_virtualenv 01:19:35 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:35 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:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:35 INFO - Using real prefix '/usr' 01:19:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:36 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:38 INFO - Installing pip.................done. 01:19:38 INFO - Return code: 0 01:19:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 01:19:38 INFO - 'HOME': '/home/cltbld', 01:19:38 INFO - 'LANG': 'en_US.UTF-8', 01:19:38 INFO - 'LANGUAGE': 'en_US:en', 01:19:38 INFO - 'LOGNAME': 'cltbld', 01:19:38 INFO - 'MAIL': '/var/mail/cltbld', 01:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:38 INFO - 'MOZ_NO_REMOTE': '1', 01:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:38 INFO - 'NO_EM_RESTART': '1', 01:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:38 INFO - 'PWD': '/builds/slave/test', 01:19:38 INFO - 'SHELL': '/bin/bash', 01:19:38 INFO - 'SHLVL': '1', 01:19:38 INFO - 'TERM': 'linux', 01:19:38 INFO - 'TMOUT': '86400', 01:19:38 INFO - 'USER': 'cltbld', 01:19:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:38 INFO - '_': '/tools/buildbot/bin/python'} 01:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:38 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:38 INFO - Cleaning up... 01:19:38 INFO - Return code: 0 01:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 01:19:38 INFO - 'HOME': '/home/cltbld', 01:19:38 INFO - 'LANG': 'en_US.UTF-8', 01:19:38 INFO - 'LANGUAGE': 'en_US:en', 01:19:38 INFO - 'LOGNAME': 'cltbld', 01:19:38 INFO - 'MAIL': '/var/mail/cltbld', 01:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:38 INFO - 'MOZ_NO_REMOTE': '1', 01:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:38 INFO - 'NO_EM_RESTART': '1', 01:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:38 INFO - 'PWD': '/builds/slave/test', 01:19:38 INFO - 'SHELL': '/bin/bash', 01:19:38 INFO - 'SHLVL': '1', 01:19:38 INFO - 'TERM': 'linux', 01:19:38 INFO - 'TMOUT': '86400', 01:19:38 INFO - 'USER': 'cltbld', 01:19:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:38 INFO - '_': '/tools/buildbot/bin/python'} 01:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:38 INFO - Downloading/unpacking psutil>=3.1.1 01:19:38 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:38 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:38 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:38 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:38 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:38 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:40 INFO - Installing collected packages: psutil 01:19:40 INFO - Running setup.py install for psutil 01:19:40 INFO - building 'psutil._psutil_linux' extension 01:19:40 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:41 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:41 INFO - building 'psutil._psutil_posix' extension 01:19:41 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:41 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:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:41 INFO - Successfully installed psutil 01:19:41 INFO - Cleaning up... 01:19:41 INFO - Return code: 0 01:19:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19: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:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:41 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 01:19:41 INFO - 'HOME': '/home/cltbld', 01:19:41 INFO - 'LANG': 'en_US.UTF-8', 01:19:41 INFO - 'LANGUAGE': 'en_US:en', 01:19:41 INFO - 'LOGNAME': 'cltbld', 01:19:41 INFO - 'MAIL': '/var/mail/cltbld', 01:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:41 INFO - 'MOZ_NO_REMOTE': '1', 01:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:41 INFO - 'NO_EM_RESTART': '1', 01:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:41 INFO - 'PWD': '/builds/slave/test', 01:19:41 INFO - 'SHELL': '/bin/bash', 01:19:41 INFO - 'SHLVL': '1', 01:19:41 INFO - 'TERM': 'linux', 01:19:41 INFO - 'TMOUT': '86400', 01:19:41 INFO - 'USER': 'cltbld', 01:19:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:41 INFO - '_': '/tools/buildbot/bin/python'} 01:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:43 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:44 INFO - Installing collected packages: mozsystemmonitor 01:19:44 INFO - Running setup.py install for mozsystemmonitor 01:19:45 INFO - Successfully installed mozsystemmonitor 01:19:45 INFO - Cleaning up... 01:19:45 INFO - Return code: 0 01:19:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 01:19:45 INFO - 'HOME': '/home/cltbld', 01:19:45 INFO - 'LANG': 'en_US.UTF-8', 01:19:45 INFO - 'LANGUAGE': 'en_US:en', 01:19:45 INFO - 'LOGNAME': 'cltbld', 01:19:45 INFO - 'MAIL': '/var/mail/cltbld', 01:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:45 INFO - 'MOZ_NO_REMOTE': '1', 01:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:45 INFO - 'NO_EM_RESTART': '1', 01:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:45 INFO - 'PWD': '/builds/slave/test', 01:19:45 INFO - 'SHELL': '/bin/bash', 01:19:45 INFO - 'SHLVL': '1', 01:19:45 INFO - 'TERM': 'linux', 01:19:45 INFO - 'TMOUT': '86400', 01:19:45 INFO - 'USER': 'cltbld', 01:19:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:45 INFO - '_': '/tools/buildbot/bin/python'} 01:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:45 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:47 INFO - warning: no files found matching '*.txt' 01:19:47 INFO - no previously-included directories found matching 'build' 01:19:47 INFO - no previously-included directories found matching 'dist' 01:19:47 INFO - no previously-included directories found matching '.git*' 01:19:47 INFO - Installing collected packages: jsonschema, functools32 01:19:47 INFO - Running setup.py install for functools32 01:19:47 INFO - warning: no files found matching '*.txt' 01:19:47 INFO - no previously-included directories found matching 'build' 01:19:47 INFO - no previously-included directories found matching 'dist' 01:19:47 INFO - no previously-included directories found matching '.git*' 01:19:47 INFO - Successfully installed jsonschema functools32 01:19:47 INFO - Cleaning up... 01:19:47 INFO - Return code: 0 01:19:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:19:47 INFO - Using env: {'DISPLAY': ':0', 01:19:47 INFO - 'HOME': '/home/cltbld', 01:19:47 INFO - 'LANG': 'en_US.UTF-8', 01:19:47 INFO - 'LANGUAGE': 'en_US:en', 01:19:47 INFO - 'LOGNAME': 'cltbld', 01:19:47 INFO - 'MAIL': '/var/mail/cltbld', 01:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:47 INFO - 'MOZ_NO_REMOTE': '1', 01:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:47 INFO - 'NO_EM_RESTART': '1', 01:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:47 INFO - 'PWD': '/builds/slave/test', 01:19:47 INFO - 'SHELL': '/bin/bash', 01:19:47 INFO - 'SHLVL': '1', 01:19:47 INFO - 'TERM': 'linux', 01:19:47 INFO - 'TMOUT': '86400', 01:19:47 INFO - 'USER': 'cltbld', 01:19:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:47 INFO - '_': '/tools/buildbot/bin/python'} 01:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:47 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:47 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:47 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:47 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:47 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:47 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:47 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:49 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:49 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:49 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:49 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:49 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:49 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:49 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:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:50 INFO - Downloading docopt-0.6.1.tar.gz 01:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:50 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:50 INFO - Running setup.py install for blobuploader 01:19:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:50 INFO - Running setup.py install for requests 01:19:51 INFO - Running setup.py install for docopt 01:19:51 INFO - Successfully installed blobuploader requests docopt 01:19:51 INFO - Cleaning up... 01:19:51 INFO - Return code: 0 01:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19: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:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:51 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 01:19:51 INFO - 'HOME': '/home/cltbld', 01:19:51 INFO - 'LANG': 'en_US.UTF-8', 01:19:51 INFO - 'LANGUAGE': 'en_US:en', 01:19:51 INFO - 'LOGNAME': 'cltbld', 01:19:51 INFO - 'MAIL': '/var/mail/cltbld', 01:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:51 INFO - 'MOZ_NO_REMOTE': '1', 01:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:51 INFO - 'NO_EM_RESTART': '1', 01:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:51 INFO - 'PWD': '/builds/slave/test', 01:19:51 INFO - 'SHELL': '/bin/bash', 01:19:51 INFO - 'SHLVL': '1', 01:19:51 INFO - 'TERM': 'linux', 01:19:51 INFO - 'TMOUT': '86400', 01:19:51 INFO - 'USER': 'cltbld', 01:19:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:51 INFO - '_': '/tools/buildbot/bin/python'} 01:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:51 INFO - Running setup.py (path:/tmp/pip-l2g_LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:51 INFO - Running setup.py (path:/tmp/pip-Qo5JBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:51 INFO - Running setup.py (path:/tmp/pip-PpvB0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:51 INFO - Running setup.py (path:/tmp/pip-EkFXhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:51 INFO - Running setup.py (path:/tmp/pip-gOsp0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:51 INFO - Running setup.py (path:/tmp/pip-464bvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:51 INFO - Running setup.py (path:/tmp/pip-yv_EDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:51 INFO - Running setup.py (path:/tmp/pip-fnMNaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:52 INFO - Running setup.py (path:/tmp/pip-iMBAjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:52 INFO - Running setup.py (path:/tmp/pip-nbJ4HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:52 INFO - Running setup.py (path:/tmp/pip-BmWeLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:52 INFO - Running setup.py (path:/tmp/pip-P885Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:52 INFO - Running setup.py (path:/tmp/pip-N9ObdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:52 INFO - Running setup.py (path:/tmp/pip-O562qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:52 INFO - Running setup.py (path:/tmp/pip-bwuKma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:52 INFO - Running setup.py (path:/tmp/pip-HWMr5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:52 INFO - Running setup.py (path:/tmp/pip-bdEvVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:52 INFO - Running setup.py install for manifestparser 01:19:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:52 INFO - Running setup.py install for mozcrash 01:19:52 INFO - Running setup.py install for mozdebug 01:19:52 INFO - Running setup.py install for mozdevice 01:19:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for mozfile 01:19:53 INFO - Running setup.py install for mozhttpd 01:19:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for mozinfo 01:19:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for mozInstall 01:19:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for mozleak 01:19:53 INFO - Running setup.py install for mozlog 01:19:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for moznetwork 01:19:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:53 INFO - Running setup.py install for mozprocess 01:19:53 INFO - Running setup.py install for mozprofile 01:19:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:54 INFO - Running setup.py install for mozrunner 01:19:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:54 INFO - Running setup.py install for mozscreenshot 01:19:54 INFO - Running setup.py install for moztest 01:19:54 INFO - Running setup.py install for mozversion 01:19:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:54 INFO - Cleaning up... 01:19:54 INFO - Return code: 0 01:19:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:54 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 01:19:54 INFO - 'HOME': '/home/cltbld', 01:19:54 INFO - 'LANG': 'en_US.UTF-8', 01:19:54 INFO - 'LANGUAGE': 'en_US:en', 01:19:54 INFO - 'LOGNAME': 'cltbld', 01:19:54 INFO - 'MAIL': '/var/mail/cltbld', 01:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:54 INFO - 'MOZ_NO_REMOTE': '1', 01:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:54 INFO - 'NO_EM_RESTART': '1', 01:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:54 INFO - 'PWD': '/builds/slave/test', 01:19:54 INFO - 'SHELL': '/bin/bash', 01:19:54 INFO - 'SHLVL': '1', 01:19:54 INFO - 'TERM': 'linux', 01:19:54 INFO - 'TMOUT': '86400', 01:19:54 INFO - 'USER': 'cltbld', 01:19:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:54 INFO - '_': '/tools/buildbot/bin/python'} 01:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:54 INFO - Running setup.py (path:/tmp/pip-0cPXgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:54 INFO - Running setup.py (path:/tmp/pip-hxpje9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:54 INFO - Running setup.py (path:/tmp/pip-rN0_vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:54 INFO - Running setup.py (path:/tmp/pip-QhxK9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:54 INFO - Running setup.py (path:/tmp/pip-xGQeCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 INFO - Running setup.py (path:/tmp/pip-jRhvWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 INFO - Running setup.py (path:/tmp/pip-vg8JH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 INFO - Running setup.py (path:/tmp/pip-Jx6sHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:55 INFO - Running setup.py (path:/tmp/pip-kSWlEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:55 INFO - Running setup.py (path:/tmp/pip-08OByK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:55 INFO - Running setup.py (path:/tmp/pip-lzimBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:55 INFO - Running setup.py (path:/tmp/pip-7jaFLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:55 INFO - Running setup.py (path:/tmp/pip-K6bULa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:55 INFO - Running setup.py (path:/tmp/pip-egz8UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:55 INFO - Running setup.py (path:/tmp/pip-Z_DgfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:55 INFO - Running setup.py (path:/tmp/pip-h77PFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:55 INFO - Running setup.py (path:/tmp/pip-3ZP6vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:57 INFO - Downloading blessings-1.6.tar.gz 01:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:57 INFO - Installing collected packages: blessings 01:19:57 INFO - Running setup.py install for blessings 01:19:58 INFO - Successfully installed blessings 01:19:58 INFO - Cleaning up... 01:19:58 INFO - Return code: 0 01:19:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:58 INFO - Reading from file tmpfile_stdout 01:19:58 INFO - Current package versions: 01:19:58 INFO - argparse == 1.2.1 01:19:58 INFO - blessings == 1.6 01:19:58 INFO - blobuploader == 1.2.4 01:19:58 INFO - docopt == 0.6.1 01:19:58 INFO - functools32 == 3.2.3-2 01:19:58 INFO - jsonschema == 2.5.1 01:19:58 INFO - manifestparser == 1.1 01:19:58 INFO - mozInstall == 1.12 01:19:58 INFO - mozcrash == 0.17 01:19:58 INFO - mozdebug == 0.1 01:19:58 INFO - mozdevice == 0.48 01:19:58 INFO - mozfile == 1.2 01:19:58 INFO - mozhttpd == 0.7 01:19:58 INFO - mozinfo == 0.9 01:19:58 INFO - mozleak == 0.1 01:19:58 INFO - mozlog == 3.2 01:19:58 INFO - moznetwork == 0.27 01:19:58 INFO - mozprocess == 0.22 01:19:58 INFO - mozprofile == 0.28 01:19:58 INFO - mozrunner == 6.11 01:19:58 INFO - mozscreenshot == 0.1 01:19:58 INFO - mozsystemmonitor == 0.3 01:19:58 INFO - moztest == 0.7 01:19:58 INFO - mozversion == 1.4 01:19:58 INFO - psutil == 3.1.1 01:19:58 INFO - requests == 1.2.3 01:19:58 INFO - wsgiref == 0.1.2 01:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19: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:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:58 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 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 01:19:58 INFO - 'HOME': '/home/cltbld', 01:19:58 INFO - 'LANG': 'en_US.UTF-8', 01:19:58 INFO - 'LANGUAGE': 'en_US:en', 01:19:58 INFO - 'LOGNAME': 'cltbld', 01:19:58 INFO - 'MAIL': '/var/mail/cltbld', 01:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:58 INFO - 'MOZ_NO_REMOTE': '1', 01:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:58 INFO - 'NO_EM_RESTART': '1', 01:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:58 INFO - 'PWD': '/builds/slave/test', 01:19:58 INFO - 'SHELL': '/bin/bash', 01:19:58 INFO - 'SHLVL': '1', 01:19:58 INFO - 'TERM': 'linux', 01:19:58 INFO - 'TMOUT': '86400', 01:19:58 INFO - 'USER': 'cltbld', 01:19:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:58 INFO - '_': '/tools/buildbot/bin/python'} 01:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Cleaning up... 01:19:58 INFO - Return code: 0 01:19:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:19: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:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:19:58 INFO - Using env: {'DISPLAY': ':0', 01:19:58 INFO - 'HOME': '/home/cltbld', 01:19:58 INFO - 'LANG': 'en_US.UTF-8', 01:19:58 INFO - 'LANGUAGE': 'en_US:en', 01:19:58 INFO - 'LOGNAME': 'cltbld', 01:19:58 INFO - 'MAIL': '/var/mail/cltbld', 01:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:58 INFO - 'MOZ_NO_REMOTE': '1', 01:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:58 INFO - 'NO_EM_RESTART': '1', 01:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:58 INFO - 'PWD': '/builds/slave/test', 01:19:58 INFO - 'SHELL': '/bin/bash', 01:19:58 INFO - 'SHLVL': '1', 01:19:58 INFO - 'TERM': 'linux', 01:19:58 INFO - 'TMOUT': '86400', 01:19:58 INFO - 'USER': 'cltbld', 01:19:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:58 INFO - '_': '/tools/buildbot/bin/python'} 01:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:58 INFO - Cleaning up... 01:19:58 INFO - Return code: 0 01:19:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:19: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:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d31ee9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', '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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:19:58 INFO - Using env: {'DISPLAY': ':0', 01:19:58 INFO - 'HOME': '/home/cltbld', 01:19:58 INFO - 'LANG': 'en_US.UTF-8', 01:19:58 INFO - 'LANGUAGE': 'en_US:en', 01:19:58 INFO - 'LOGNAME': 'cltbld', 01:19:58 INFO - 'MAIL': '/var/mail/cltbld', 01:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:58 INFO - 'MOZ_NO_REMOTE': '1', 01:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:58 INFO - 'NO_EM_RESTART': '1', 01:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:58 INFO - 'PWD': '/builds/slave/test', 01:19:58 INFO - 'SHELL': '/bin/bash', 01:19:58 INFO - 'SHLVL': '1', 01:19:58 INFO - 'TERM': 'linux', 01:19:58 INFO - 'TMOUT': '86400', 01:19:58 INFO - 'USER': 'cltbld', 01:19:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:58 INFO - '_': '/tools/buildbot/bin/python'} 01:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:58 INFO - Downloading/unpacking flake8 01:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:20:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:20:00 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:20:00 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:20:00 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:20:00 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:20:00 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:20:00 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:20:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:20:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:20:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:20:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:20:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:20:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:20:01 INFO - no previously-included directories found matching 'docs/_build' 01:20:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:20:01 INFO - Running setup.py install for pep8 01:20:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:20:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:20:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:20:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:20:01 INFO - no previously-included directories found matching 'docs/_build' 01:20:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:20:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:20:01 INFO - Cleaning up... 01:20:01 INFO - Return code: 0 01:20:01 INFO - Running post-action listener: _resource_record_post_action 01:20:01 INFO - Running post-action listener: _start_resource_monitoring 01:20:01 INFO - Starting resource monitoring. 01:20:01 INFO - ##### 01:20:01 INFO - ##### Finished create-virtualenv step (success) 01:20:01 INFO - ##### 01:20:01 INFO - ##### 01:20:01 INFO - ##### Running install step. 01:20:01 INFO - ##### 01:20:01 INFO - Running pre-action listener: _resource_record_pre_action 01:20:01 INFO - Running main action method: install 01:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:02 INFO - Reading from file tmpfile_stdout 01:20:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:20:02 INFO - Reading from file tmpfile_stdout 01:20:02 INFO - Output received: 01:20:02 INFO - Usage: mozinstall [options] installer 01:20:02 INFO - Options: 01:20:02 INFO - -h, --help show this help message and exit 01:20:02 INFO - -d DEST, --destination=DEST 01:20:02 INFO - Directory to install application into. [default: 01:20:02 INFO - "/builds/slave/test"] 01:20:02 INFO - --app=APP Application being installed. [default: firefox] 01:20:02 INFO - mkdir: /builds/slave/test/build/application 01:20:02 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:20:02 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:20:18 INFO - Reading from file tmpfile_stdout 01:20:18 INFO - Output received: 01:20:18 INFO - /builds/slave/test/build/application/firefox/firefox 01:20:18 INFO - Running post-action listener: _resource_record_post_action 01:20:18 INFO - ##### 01:20:18 INFO - ##### Finished install step (success) 01:20:18 INFO - ##### 01:20:18 INFO - ##### 01:20:18 INFO - ##### Running run-tests step. 01:20:18 INFO - ##### 01:20:18 INFO - Running pre-action listener: _resource_record_pre_action 01:20:18 INFO - Running main action method: run_tests 01:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:20:18 INFO - Python 2.7.3 01:20:18 INFO - Return code: 0 01:20:18 INFO - grabbing minidump binary from tooltool 01:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:18 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 0x1ee02e0>, '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 0x1e4c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:20:18 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:20:18 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:20:18 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:20:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:18 INFO - Return code: 0 01:20:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:20:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:20:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:20:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:20:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:20:19 INFO - Return code: 0 01:20:19 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-006', '--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:20:19 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-006 --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:20:19 INFO - Using env: {'DISPLAY': ':0', 01:20:19 INFO - 'HOME': '/home/cltbld', 01:20:19 INFO - 'LANG': 'en_US.UTF-8', 01:20:19 INFO - 'LANGUAGE': 'en_US:en', 01:20:19 INFO - 'LOGNAME': 'cltbld', 01:20:19 INFO - 'MAIL': '/var/mail/cltbld', 01:20:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:20:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:19 INFO - 'MOZ_NO_REMOTE': '1', 01:20:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:19 INFO - 'NO_EM_RESTART': '1', 01:20:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:19 INFO - 'PWD': '/builds/slave/test', 01:20:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:20:19 INFO - 'SHELL': '/bin/bash', 01:20:19 INFO - 'SHLVL': '1', 01:20:19 INFO - 'TERM': 'linux', 01:20:19 INFO - 'TMOUT': '86400', 01:20:19 INFO - 'USER': 'cltbld', 01:20:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852', 01:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:19 INFO - '_': '/tools/buildbot/bin/python'} 01:20:19 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-006', '--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:20:19 INFO - mozversion application_buildid: 20160627130921 01:20:19 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:20:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:20:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:19 INFO - mozversion application_name: Firefox 01:20:19 INFO - mozversion application_remotingname: firefox-dev 01:20:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:19 INFO - mozversion application_vendor: Mozilla 01:20:19 INFO - mozversion application_version: 49.0a2 01:20:19 INFO - mozversion platform_buildid: 20160627130921 01:20:19 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:20:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:19 INFO - mozversion platform_version: 49.0a2 01:20:19 INFO - using testdate: 1467102019 01:20:19 INFO - actual date: 1467102019 01:20:19 INFO - starting webserver on 'localhost:41574' 01:20:19 INFO - SUITE-START | Running 2 tests 01:20:19 INFO - TEST-START | dromaeo_css 01:20:19 INFO - operating with platform_type : linux_ 01:20:19 INFO - Initialising browser for dromaeo_css test... 01:20:19 INFO - TEST-INFO | started process 12814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PScxi/profile http://localhost:41574/getInfo.html) 01:20:23 INFO - PROCESS | 12814 | __metrics Screen width/height:1600/1200 01:20:23 INFO - PROCESS | 12814 | colorDepth:24 01:20:23 INFO - PROCESS | 12814 | Browser inner width/height: 1024/697 01:20:23 INFO - PROCESS | 12814 | __metrics 01:20:24 ERROR - PROCESS | 12814 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:20:25 INFO - TEST-INFO | 12814: exit 0 01:20:25 INFO - Browser initialized. 01:20:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:20:25 INFO - TEST-INFO | started process 12941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PScxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:36 INFO - PROCESS | 12941 | RSS: Main: 156327936 01:20:36 INFO - PROCESS | 12941 | 01:21:26 INFO - PROCESS | 12941 | 1467102086520 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:34 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41574/tests/dromaeo/cssquery-ext.html) 01:23:35 INFO - PROCESS | 12941 | RSS: Main: 159416320 01:23:35 INFO - PROCESS | 12941 | 01:26:37 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-ext.html (next: http://localhost:41574/tests/dromaeo/cssquery-jquery.html) 01:26:38 INFO - PROCESS | 12941 | RSS: Main: 157474816 01:26:38 INFO - PROCESS | 12941 | 01:29:40 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41574/tests/dromaeo/cssquery-mootools.html) 01:29:40 INFO - PROCESS | 12941 | RSS: Main: 157208576 01:29:40 INFO - PROCESS | 12941 | 01:32:42 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41574/tests/dromaeo/cssquery-prototype.html) 01:32:43 INFO - PROCESS | 12941 | RSS: Main: 157442048 01:32:43 INFO - PROCESS | 12941 | 01:35:45 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41574/tests/dromaeo/cssquery-yui.html) 01:35:46 INFO - PROCESS | 12941 | RSS: Main: 159219712 01:35:46 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | Cycle 1(1): loaded http://localhost:41574/tests/dromaeo/cssquery-yui.html (next: http://localhost:41574/tests/dromaeo/cssquery-dojo.html) 01:38:48 INFO - PROCESS | 12941 | RSS: Main: 159145984 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | __start_tp_report 01:38:48 INFO - PROCESS | 12941 | _x_x_mozilla_page_load 01:38:48 INFO - PROCESS | 12941 | _x_x_mozilla_page_load_details 01:38:48 INFO - PROCESS | 12941 | |i|pagename|runs| 01:38:48 INFO - PROCESS | 12941 | |0;dojo.html;3399.677030682085;3455.032590874556;3461.6192218855936;3468.4277094279446;3477;5804.941950580493;5824.155497452867;5833.445822646847;5833.912491312633;5926.081457374103;5788.42115788421;5866.530677545797;5870.589058765888;5879.0593505039205;5919.904817608745;5235.712035838027;5320.334958130234;5354.892902141974;5364.275822763935;5377.193420986844;5291.947080529184;5293.179557168645;5314.149736042234;5400.972995135019;5402.648827826199;5287.233351164079;5304.893902121975;5305.946940530604;5317.813876514323;5441.564674826024;5374.462553744634;5386.542143917772;5397.217403476474;5398.433164517748;5418.512333889968;5113.079645663779;5204.843854684365;5210.478952104797;5264.42091369949;5353.491418315254;5702.857428564277;5780.682062486561;5814.447627475383;5828.9417105828825;5857.4435428634215;6243.65659888706;6312.747490100391;6342.175517182783;6351.110844481776;6365.522585806083;6113.597930965863;6187.535934804862;6200.503959683215;6374.171357723512;6406.007068904327;5900.675462849585;5900.734466948998;5901.527877769811;5910.615809972338;5911.733971971272;6445.387688169616;6463.676816159267;6472.838179045561;6479.125318082093;6485.092087107809;5848.561357898175;6029.8191054268445;6050.606710563799;6078.908816367758;6202.317745048132;6199.485122433049;6207;6224.688765561704;6252.968735156295;6253.468455181361;6210.285817130997;6212.968935155386;6214.533909956771;6218.875622487525;6243.219597550306;6000.669963151981;6125.296497837281;6135.07973803933;6146.016637338004;6250.562460627803;4698.577128058491;4720.409948756405;4729.55069268419;4734.171519983989;4734.55021772931;4119.855805046809;4196.727212731163;4238.173556156582;4244.129953359616;4245.3844192591905;5792.391798861143;5881.264841894763;5925.288965324103;5971.343152253248;5998.190244316961;6200.627962322275;6214.161088253119;6242.531810114259;6246.063090536456;6274.780382686676;6016.578839481282;6017.608855424383;6034.2155519782145;6076.969615151896;6097.817065488042;5228.686278823283;5312.548433383128;5328.893422131536;5371.865703357447;5380.300560927133;6459;6505;6514.771982980573;6524.771632992917;6525.934740652628;6106.450419462092;6392.936070639327;6394.840128996812;6401.487880969418;6403.103565500926;6291.685415729104;6337.493000560036;6356.713947872265;6415.069814876723;6421.614703117828;6171.59884607499;6180.072989051679;6182.598131121643;6184.5980011299125;6191.597546159485;6125.601835880653;6183.350748171377;6300.810975670737;6304.810855674337;6306.779262725782;6025.457708806229;6146.139540464249;6158.414950579688;6173.9073913892225;6190.783322583688;6116;6119.84700382494;6143.447089761943;6157;6185.597936134137;5831.679257640871;5983;6006.8498287541415;6060.575759696779;6114.266288045463;6135.693215339126;6206.503479721701;6212.099245609452;6218.098375735583;6228.875422491434;6047.727852246748;6060.848478788065;6080.473325471305;6101.054336577838;6124.350421260821 01:38:48 INFO - PROCESS | 12941 | |1;ext.html;578.7337824600684;641.5412979719499;645.5223134880188;648.8961766117422;651.3746803069055;48118;50074.749626251905;50186.24720629193;50264;52508.737456312665;50152.74923625386;50463.495365046336;50758;50782.49217507824;50862.49137508624;9277.489738064403;9377.296702747288;9402.858957115615;9412.058794120601;9448.574814133346;9081.046490118542;9177.219936305388;9205.631774729036;9234.86147707785;9267.119623635745;9181.540922953825;9280.396774209688;9286.442813431217;9292.070792920722;9295.39579927306;9214.631414743402;9259.722208333727;9261.120193581599;9275.768105797375;9306.302027347976;9159.221466175382;9201.631934722604;9231.39995900271;9231.815363692756;9233.07669233078;45923.311150332775;46631.300530492066;46695;46801;46801.5319846804;3759.9248015039548;3908.472356231901;3921.137349783043;3953.4860468139245;4037.2732908076537;35995.64004359949;36372.63627363719;36523;36530.81734591337;37000.629993699986;4633;4667.813287468532;4712.363830882821;4726.7400292983875;4774.355462012653;405714;406400;408190;408234;408982.99999999703;70304;70689.29310706827;71019.28980710126;71190.64404677943;71359.64320178366;40323.395149072785;41342.1731565367;41425;43167.56832431635;43510.69467915968;19942;19996.100175492138;20042.89978550127;20092.59814803696;20096.19615215375;15444;15583.376664933276;15585.532434026998;15596.766048509282;15642.296096675676;21811.23660671869;22451.32646020589;22462;22525.662115068288;22535.549289014456;7513.173550909396;7790.922090779133;7927.84144317122;8034.638441270157;8056.8388632227025;1043.7583252152172;1113.2263077161458;1140.156284349592;1178.9742923656474;1218.7318789866215;33802.66197338044;34194.48708269378;34342.65657343445;34403.635550920364;34563.82718086393;1168.1822724093;1191.0888170549536;1197.245735186844;1222.743223922986;1235.8393408856791;17903.836250643668;18107.637847242982;18214.33183981257;18308.084595770157;18373.908130459262;715833;725493;728299;931539;1077152;65524;65607;65801.67099164473;65943;66011;1399.6221020324658;1400.824896887889;1440.0135906903595;1446.3925151436422;1514.1142431677372;33006.669933300356;33710.49434258537;33890.68581766335;33996.66003339935;34475;56790.716046419504;56824.71587642201;57360.42639573551;57413.425865740806;57418;424864;427409;428640;428886;429458;30736.23159420943;31184.22039449032;31207.219819504695;31287.687123129388;32415.35169296648;54576.72711636416;54664.72667636796;54737;55520.44479555153;56164;46117.76941115273;47109.7644511789;47887.521124788305;48008;48209.75895120502;46946;47012.52987470081;47243.763781180875;47363.28955065746;47579.52420475889;43747.34378984254;43769.34345984749;43817.34273985829;46395.10878195881;46588.53411465842;38994.80502597469;40949.38575921423;41043.79478102591;41682.37476437795;41949.37075943924;35818.925432237076;36737.44422149643;39135;39410.605893940694;39992.8000360008 01:38:48 INFO - PROCESS | 12941 | |2;jquery.html;424.51181141687067;429.46317103620476;434.5567521128449;439.30370362974685;452.934324522944;18693.906530467346;20478.385648430532;21079.578408431822;21325.786742132575;21520.569588608258;19665.60668786627;19929.302474413398;20663.690044649342;20687.37937861863;20693;5834.095715164146;5992.5505587080925;6016.42843929826;6020.879582408349;6037.7584896604085;5684.261046064026;5887.058070708687;5916.497097746696;5959.374265702104;5962.04607262838;5897.793577224798;5903.3211180714125;5905.055191169414;5923.644581325113;5941.643501389931;5685.204071430003;5869.325027621835;5910.143029260755;5911.615744976562;5922.052471604566;5257.474252574751;5300.734963251822;5312.92030619541;5336.599755018389;5348.812791552277;24407.511849763083;24491.87754061236;24648.753512464824;24654.383640408952;24742.134025309027;2498.650188973545;2576.330154159932;2595.8053146014126;2607.2178346495975;2743.1359121876544;15220.467283645019;15593.92203038989;15700.68598628021;15755.921220393939;15797.92101039499;2021.2319318658815;2056.259746491262;2097.265956915083;2131.8507704460694;2183.617866873291;81329;84423;84508.57745711232;84890.57554712187;85511;10941.4529273536;11318.26431281964;11602;11691.415429228504;11778.293302401884;16179.595510112342;16274.918625406797;16304.836951630568;16313.836861631231;16397.836021639632;8395.790105247295;8627.568621568897;8682.175193356747;8773.38586298953;8794.34042446819;8328.375371847136;8490.236228337339;8840.115988401109;9167.541622918961;9209.493477858781;6864.5881247125335;6963.1296087989;6972.895406568906;6998.020277161201;7128.572285662877;2048.754149502069;2098.8320934325216;2099.4016705238932;2104.5054412213117;2152.160657343637;1037.3361048928691;1074.4788777442934;1115.7545340025345;1132.4111462039857;1182.7634473105413;18168.45494635163;19968.500787480138;20292.18831246763;20359.796402036085;20675.689864652042;1080.6920027792041;1080.8324709670014;1101.763120928988;1102.388174563109;1140.441183819939;11556.76886462266;11819.468123934443;11877.643670689893;11960.222585532087;12118.333491657868;463826;464708;465826;466609;489495;49890.25164622533;66897.66551167212;74758.62620686862;78449.60775196088;85602.14397855941;1106.3306699446719;1114.0474893965866;1156.5720683347215;1167.795635763738;1187.958421455245;18276.45170644883;18744.343947961755;18797.154128064543;18985.620287593894;19004.71492927635;41301;41733;42301.36547951845;42580.36129457998;43133.784331078146;62131.689341553;64006;66128;66166.33833661601;66548;9085.77285567866;9268.536573171179;9278.675246366345;9293.070692930653;9323.953380233055;13289.867101328862;13918;14383.208923509308;14404.42382304696;14722.705545888808;12557.560485382968;12560.811587826007;12568.245905245349;12637.2417654941;12683.619491415273;11949.163558551165;12065.638030859089;12195.878041219474;12797.744045119232;12880.677983050498;12232;12233.69415764613;12300.323482208565;12521.624351269476;13041.934790326368;9045.864312035457;9095.454272743656;9272.350935434724;9287.674931377369;9360.391574547633;9586.952065239908;12755.93622031884;12785.808212877;12795.872041279841;12849.164804287691 01:38:48 INFO - PROCESS | 12941 | |3;mootools.html;1548.589623749706;1603.0782300177398;1777.8933264004152;1898.392514395394;1898.667733146699;8464.492130472176;9159.40463869848;9224.21594164496;9885.308028438012;9893.208543316545;8908.554572271376;9187.127222913829;9234.584443700032;9251.768705782359;9289.953550232256;2532.898684052636;2543.8855251513633;2570.9357266068405;2573.562494375961;2574.04760238711;2441.401856545149;2517.7230504644567;2519.5842685956886;2519.6976362836485;2522.3441905104623;2455.8403703759286;2487;2536.264483299841;2538.2512158913164;2544.860032698201;2470.28361775085;2501.562226610345;2506.4611108611552;2512.811539134563;2535.3408113890337;2497.675302210701;2504.511620234055;2520.483300923325;2522.7981761459223;2523.9242822715164;9846.310758246926;9869.950650246774;9882.604695812159;9913.058259465339;9920.801583968352;5891.558133139989;5901.085331773582;5974.820755377302;5989.8203053908455;6029.54778391618;3575.2670702505925;3600.063983364344;3712.814359282052;3779.4708740776314;3819.8281077351585;1208.7456892894777;1217.2392254840724;1244.9066320026034;1252.7118762684543;1261.6467389131058;13229.999999999904;13243.20540767557;13258.138221015699;13259.867401326057;13488.797668034988;4986.351774269394;5001.8499445016705;5114;5154.974225128925;5169.767360468788;11042.447877606088;11114;11149.72125696864;11152.665420037412;11181.83227251592;5873;5873.236479257669;5879.265091863517;5883.499902508249;5899.882002359929;4724.905501889943;5380.677159370451;5415.133578627479;5461.863453413617;5505.421930697299;4418.5802348776815;4450.888727781831;4457.398251236042;4459.732416055047;4476.082403107355;1403.6701375176826;1432.10493441599;1442.6321288071474;1443.6390902274431;1463.0563286680033;918.6784625381197;994.627014869424;1037.1754455208127;1045.7751583409604;1080.152080616712;6309.08518264849;6438.806835794933;6601.70292336846;6636.336366363325;6840.589564626139;1003.5584342889106;1043.6555936540924;1054.1250761867784;1066.9039786419105;1088.689723428819;4536.4102666653125;4541.9545804542195;4578.381918441034;4592.173408786383;4596.908061838744;12121.878781212252;12465.18976266558;12822.422990965242;12840.55058072963;12843.165194262343;12405.379731013414;12806.167599106027;12918.289494077915;12926.289054101926;12957.157784743962;8945.507997060095;9045.592948317342;9098.590563424661;9103.999999999867;9146.908530914605;6339.904901426575;6436.195475565554;6483.384078512534;6575.736970521126;6615.073889655549;11003.669889903316;11032.724181895517;11422.600208992646;11694.415279236175;11752.823707644222;11535.307881527135;11576.36330001858;11894.940525297665;11982.10134239918;12051;7796.259355361231;8338.166183381856;8488.278496327634;8629.180227878342;8785.736427907173;9616.95191524038;9631.373960692532;9671.032896710272;9688.70933871985;9729.22166226686;8523.914760852313;8540.70107546233;8569.914300856912;8616.267617252353;8733.039365669643;8303.750887473385;8331.375146863887;8424.157584241526;8437;8607.784805379915;7733.883991740241;7779.416543759354;7786.88319675194;7832.2559356863285;7841.255080767546;5353.143497040455;5377.3816011159215;5431.103867861917;5508.862278443071;5574.219609254626;5378.757955891916;5414.945850541601;5488.890222195613;5493.176023596492;5513.3108361454815 01:38:48 INFO - PROCESS | 12941 | |4;prototype.html;356.8287222133376;361.2720368457558;368.85983326336;372.2090557565174;372.983215755291;5711.485966263035;5797.927383434067;5837.503812175964;5950.642961422318;5966.642001479914;5615.7472913718875;5692.5161361284345;5716.456936591017;5717.285339332583;5741.712914354286;4426.601605855472;4454.507739907127;4477.3731677565165;4486.641068714495;4496.842610508633;4424.181526417607;4464.732116073046;4478.73823719023;4483.5516448355065;4491.887702807423;4412.338149277602;4421.557844215568;4428.623566996809;4431.936335279542;4482.529334419888;4471.262241730127;4472.5303843096335;4475.261581838992;4515.864524064284;4528.139653465831;3744.5506539215467;3913.9217215655813;4016.136530645896;4031.3751368537924;4047;5587.9941610510095;5599.8880022399735;5664.348599911022;5672.5178359839465;5699.943000569982;5219.660722053092;5220.477952204749;5225.346831646044;5248.921266181011;5250.159974404115;6004.879902401927;6051.788187413464;6145.770845830852;6146.35463276354;6166.136740856284;4371.453568303962;4374.759388233646;4388.978055109704;4399;4399.450068741407;6331.68341582919;6395.488360931115;6421.133147025185;6449.96775016122;6461.5153863459955;4215.3044747616295;4447.822087116544;4459.888502787457;4463.24124898768;4472.642188624902;4507;4508.233600287894;4545.090981803586;4550.431196100488;4580.625812256377;5212.400573934046;5225.4774522548205;5236.764345604457;5241.0828105081455;5242.633015688942;5890.175375447441;5954.523638108941;6105.542084343692;6107.541934354941;6108.205933228652;1552.4023251048202;1557.0813220200137;1570.4267942201013;1577.085290531489;1578.8105427348792;977.359829311802;984.9507524623883;989.6239429017071;1004.9196064314838;1010.4745532323151;5184.714840683799;5269.736513174326;5284.313039304866;5299.019681358961;5338.839834804962;5526.58550608706;5552.639078459968;5582.381109478206;5602.487328421304;5619.880966063792;4937.530934561211;5169.578365949394;5178.715170665574;5270.552003079782;5303.28405665238;2961.0672638119354;2994.625671791026;3030.3636236390166;3037.635483741921;3057.92355191122;5591.329040515164;5664.660120392789;5700.714964251771;5764.106563482667;5764.394738552475;6023.909641355383;6476.114331401216;6479.254885688112;6487.772927947499;6541.182352205974;6484.708188131545;6505.934940650627;6539.182602174728;6570.507211959122;6585.7487077455135;6086.178365920544;6303.275123360872;6335.556511044183;6339.175907132043;6374.808755737336;6238.315654773277;6331.461825744863;6376.39424254695;6376.840578985562;6396;6487.675616219264;6543.5419520635005;6575.309592492719;6582.308857570078;6589.308122647053;4484.484284307347;4506.774661266858;4508.977455112704;4510.548945105464;4545.954540454685;6162.845928851814;6377.7130029147875;6462.4183823456115;6463.935360646521;6481.319461456479;6095.299040610209;6142.846428839315;6151.6001459904965;6180.7527698891545;6219.564630476004;6003.189569408074;6162.442586326624;6187.257529096537;6188.319284878569;6220.25832766826;6022.247219097613;6071.633882376606;6085.69571521431;6115.388461153849;6124.203853499017;6207.16203312547;6208.50331973432;6208.906866397098;6209.285932117864;6251.874962500816;5810.477057064884;6045.486133678686;6049.576529642883;6056.121862330026;6120.632762034292 01:38:48 INFO - PROCESS | 12941 | |5;yui.html;738.6860584251692;775.3254668438459;824.0688022534536;825.030589057857;826.1119296755988;15648.765268520967;16265.34938602456;16960.660786784258;16983.320667173328;17059.91470042651;15642.374305027784;15750.448734294301;15761.684766304666;15788.210589470538;15805.920970395133;727.9636018199095;842.9157084291552;861.0958493581729;872.2672954718035;876.9736907892774;870.0342619692136;872.4808738800403;875.5622188905547;878.2841983783228;878.7627340618029;916.8991410944791;922.0226559846584;928.0951072704094;928.5821380378823;932.0493097041015;914.7575892388522;915.0026471146416;918.5131880103556;919.1497864475367;921.5069937583428;671.5735507952437;675.1459403854079;675.746595026865;676.5433332500543;678.6911955060435;15477.5356739298;15488.148151851643;15489.690206195926;15519.379224831106;15534;13588.93205533966;14025.088369255966;14108;14530.200838953853;15800;14066.71866562663;14135.85864141366;14148;14165.362558684885;14256.073355231876;4687.812487500496;4714.622830173578;4780.593649539794;4792.856214313576;4799.976000120012;73981.26018739743;82514.58742706248;82608;82971.5851420745;83470.58264708638;12117.27296362221;12619.116661833767;12632.494700211888;12689.365531723377;12798.552050678181;22449.551008979728;22608.208712694977;22635.094596216295;22699.659505107436;22717.43206419853;9167.95416022929;9190.356675032683;9239.39943903644;9460.337776355727;9510.001449847805;4942.5057494251005;5056.387041450212;5144.9742751286;5171.534561889448;5232.372115346183;3915.92168156641;4007.0984028593916;4029.9798501007895;4120.62914337711;4344.022594916119;681.6012632609879;686.5708931917552;688.8691148681735;694.0283602955801;704.5913370245246;805.4764403138007;817.1746535998684;823.9629216685144;831.1729828820362;852.7825404521807;10559.947200264103;10788;10867.021968022758;10892.183086268562;10953.726156845983;752.7177308509309;799.4883274704194;806.7136166660869;808.6441965535263;814.1329484099415;4937.746405021822;4988.7505624718615;4999.125153098266;5094.770735316845;5098.158803797406;84176;118844;135098;137506;138005;90463;91363;96971.51514242384;103059.48470257751;106441;76320.9999999989;80517;81108.59445702734;90479;94206;9027.729168124966;9028.683996060106;9266.583003764981;9335.813283734424;9374.109459601326;45047.774761125984;45830.31254531251;51714.48285517247;51759.70600735012;53559.7322013403;67387;69609.65195173991;77616.22383776316;78720;79341;12957.41691623898;13200.405981730653;13249.337533123113;13483.797743034058;13756.518521851687;15188.46840360582;15301.234938253265;15378.154201518577;15941.840581594035;16043.759343609621;13955.232462214675;14093;14142.22217778032;14388.856111438752;14402.927985360006;14494;14752.409903603735;14910.552683419515;15032.774508382601;15467.5359739208;14872.702545948803;14987.550373488813;15120.470783522524;15386.769198461809;15511.146886921328;11216.383098929637;11342.716432089264;11571.479283432434;11616.361100139573;11617.128715346551;11609.709757256136;11788.174827762317;11839.704007399883;11869.287842729464;11873.400834304115 01:38:48 INFO - PROCESS | 12941 | __end_tp_report 01:38:48 INFO - PROCESS | 12941 | __start_cc_report 01:38:48 INFO - PROCESS | 12941 | _x_x_mozilla_cycle_collect,330 01:38:48 INFO - PROCESS | 12941 | __end_cc_report 01:38:48 INFO - PROCESS | 12941 | __startTimestamp1467103128746__endTimestamp 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | ------- Summary: start ------- 01:38:48 INFO - PROCESS | 12941 | Number of tests: 6 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#0] dojo.html Cycles:165 Average:5812.64 Median:6060.58 stddev:662.00 (10.9%) stddev-sans-first:636.40 01:38:48 INFO - PROCESS | 12941 | Values: 3399.7 3455.0 3461.6 3468.4 3477.0 5804.9 5824.2 5833.4 5833.9 5926.1 5788.4 5866.5 5870.6 5879.1 5919.9 5235.7 5320.3 5354.9 5364.3 5377.2 5291.9 5293.2 5314.1 5401.0 5402.6 5287.2 5304.9 5305.9 5317.8 5441.6 5374.5 5386.5 5397.2 5398.4 5418.5 5113.1 5204.8 5210.5 5264.4 5353.5 5702.9 5780.7 5814.4 5828.9 5857.4 6243.7 6312.7 6342.2 6351.1 6365.5 6113.6 6187.5 6200.5 6374.2 6406.0 5900.7 5900.7 5901.5 5910.6 5911.7 6445.4 6463.7 6472.8 6479.1 6485.1 5848.6 6029.8 6050.6 6078.9 6202.3 6199.5 6207.0 6224.7 6253.0 6253.5 6210.3 6213.0 6214.5 6218.9 6243.2 6000.7 6125.3 6135.1 6146.0 6250.6 4698.6 4720.4 4729.6 4734.2 4734.6 4119.9 4196.7 4238.2 4244.1 4245.4 5792.4 5881.3 5925.3 5971.3 5998.2 6200.6 6214.2 6242.5 6246.1 6274.8 6016.6 6017.6 6034.2 6077.0 6097.8 5228.7 5312.5 5328.9 5371.9 5380.3 6459.0 6505.0 6514.8 6524.8 6525.9 6106.5 6392.9 6394.8 6401.5 6403.1 6291.7 6337.5 6356.7 6415.1 6421.6 6171.6 6180.1 6182.6 6184.6 6191.6 6125.6 6183.4 6300.8 6304.8 6306.8 6025.5 6146.1 6158.4 6173.9 6190.8 6116.0 6119.8 6143.4 6157.0 6185.6 5831.7 5983.0 6006.8 6060.6 6114.3 6135.7 6206.5 6212.1 6218.1 6228.9 6047.7 6060.8 6080.5 6101.1 6124.4 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#1] ext.html Cycles:180 Average:72426.45 Median:25375.38 stddev:160365.97 (632.0%) stddev-sans-first:160725.10 01:38:48 INFO - PROCESS | 12941 | Values: 578.7 641.5 645.5 648.9 651.4 48118.0 50074.7 50186.2 50264.0 52508.7 50152.7 50463.5 50758.0 50782.5 50862.5 9277.5 9377.3 9402.9 9412.1 9448.6 9081.0 9177.2 9205.6 9234.9 9267.1 9181.5 9280.4 9286.4 9292.1 9295.4 9214.6 9259.7 9261.1 9275.8 9306.3 9159.2 9201.6 9231.4 9231.8 9233.1 45923.3 46631.3 46695.0 46801.0 46801.5 3759.9 3908.5 3921.1 3953.5 4037.3 35995.6 36372.6 36523.0 36530.8 37000.6 4633.0 4667.8 4712.4 4726.7 4774.4 405714.0 406400.0 408190.0 408234.0 408983.0 70304.0 70689.3 71019.3 71190.6 71359.6 40323.4 41342.2 41425.0 43167.6 43510.7 19942.0 19996.1 20042.9 20092.6 20096.2 15444.0 15583.4 15585.5 15596.8 15642.3 21811.2 22451.3 22462.0 22525.7 22535.5 7513.2 7790.9 7927.8 8034.6 8056.8 1043.8 1113.2 1140.2 1179.0 1218.7 33802.7 34194.5 34342.7 34403.6 34563.8 1168.2 1191.1 1197.2 1222.7 1235.8 17903.8 18107.6 18214.3 18308.1 18373.9 715833.0 725493.0 728299.0 931539.0 1077152.0 65524.0 65607.0 65801.7 65943.0 66011.0 1399.6 1400.8 1440.0 1446.4 1514.1 33006.7 33710.5 33890.7 33996.7 34475.0 56790.7 56824.7 57360.4 57413.4 57418.0 424864.0 427409.0 428640.0 428886.0 429458.0 30736.2 31184.2 31207.2 31287.7 32415.4 54576.7 54664.7 54737.0 55520.4 56164.0 46117.8 47109.8 47887.5 48008.0 48209.8 46946.0 47012.5 47243.8 47363.3 47579.5 43747.3 43769.3 43817.3 46395.1 46588.5 38994.8 40949.4 41043.8 41682.4 41949.4 35818.9 36737.4 39135.0 39410.6 39992.8 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#2] jquery.html Cycles:180 Average:28838.30 Median:24570.32 stddev:77277.54 (314.5%) stddev-sans-first:77464.87 01:38:48 INFO - PROCESS | 12941 | Values: 424.5 429.5 434.6 439.3 452.9 18693.9 20478.4 21079.6 21325.8 21520.6 19665.6 19929.3 20663.7 20687.4 20693.0 5834.1 5992.6 6016.4 6020.9 6037.8 5684.3 5887.1 5916.5 5959.4 5962.0 5897.8 5903.3 5905.1 5923.6 5941.6 5685.2 5869.3 5910.1 5911.6 5922.1 5257.5 5300.7 5312.9 5336.6 5348.8 24407.5 24491.9 24648.8 24654.4 24742.1 2498.7 2576.3 2595.8 2607.2 2743.1 15220.5 15593.9 15700.7 15755.9 15797.9 2021.2 2056.3 2097.3 2131.9 2183.6 81329.0 84423.0 84508.6 84890.6 85511.0 10941.5 11318.3 11602.0 11691.4 11778.3 16179.6 16274.9 16304.8 16313.8 16397.8 8395.8 8627.6 8682.2 8773.4 8794.3 8328.4 8490.2 8840.1 9167.5 9209.5 6864.6 6963.1 6972.9 6998.0 7128.6 2048.8 2098.8 2099.4 2104.5 2152.2 1037.3 1074.5 1115.8 1132.4 1182.8 18168.5 19968.5 20292.2 20359.8 20675.7 1080.7 1080.8 1101.8 1102.4 1140.4 11556.8 11819.5 11877.6 11960.2 12118.3 463826.0 464708.0 465826.0 466609.0 489495.0 49890.3 66897.7 74758.6 78449.6 85602.1 1106.3 1114.0 1156.6 1167.8 1188.0 18276.5 18744.3 18797.2 18985.6 19004.7 41301.0 41733.0 42301.4 42580.4 43133.8 62131.7 64006.0 66128.0 66166.3 66548.0 9085.8 9268.5 9278.7 9293.1 9324.0 13289.9 13918.0 14383.2 14404.4 14722.7 12557.6 12560.8 12568.2 12637.2 12683.6 11949.2 12065.6 12195.9 12797.7 12880.7 12232.0 12233.7 12300.3 12521.6 13041.9 9045.9 9095.5 9272.4 9287.7 9360.4 9587.0 12755.9 12785.8 12795.9 12849.2 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#3] mootools.html Cycles:180 Average:6426.68 Median:4585.28 stddev:3704.00 (80.8%) stddev-sans-first:3696.25 01:38:48 INFO - PROCESS | 12941 | Values: 1548.6 1603.1 1777.9 1898.4 1898.7 8464.5 9159.4 9224.2 9885.3 9893.2 8908.6 9187.1 9234.6 9251.8 9290.0 2532.9 2543.9 2570.9 2573.6 2574.0 2441.4 2517.7 2519.6 2519.7 2522.3 2455.8 2487.0 2536.3 2538.3 2544.9 2470.3 2501.6 2506.5 2512.8 2535.3 2497.7 2504.5 2520.5 2522.8 2523.9 9846.3 9870.0 9882.6 9913.1 9920.8 5891.6 5901.1 5974.8 5989.8 6029.5 3575.3 3600.1 3712.8 3779.5 3819.8 1208.7 1217.2 1244.9 1252.7 1261.6 13230.0 13243.2 13258.1 13259.9 13488.8 4986.4 5001.8 5114.0 5155.0 5169.8 11042.4 11114.0 11149.7 11152.7 11181.8 5873.0 5873.2 5879.3 5883.5 5899.9 4724.9 5380.7 5415.1 5461.9 5505.4 4418.6 4450.9 4457.4 4459.7 4476.1 1403.7 1432.1 1442.6 1443.6 1463.1 918.7 994.6 1037.2 1045.8 1080.2 6309.1 6438.8 6601.7 6636.3 6840.6 1003.6 1043.7 1054.1 1066.9 1088.7 4536.4 4542.0 4578.4 4592.2 4596.9 12121.9 12465.2 12822.4 12840.6 12843.2 12405.4 12806.2 12918.3 12926.3 12957.2 8945.5 9045.6 9098.6 9104.0 9146.9 6339.9 6436.2 6483.4 6575.7 6615.1 11003.7 11032.7 11422.6 11694.4 11752.8 11535.3 11576.4 11894.9 11982.1 12051.0 7796.3 8338.2 8488.3 8629.2 8785.7 9617.0 9631.4 9671.0 9688.7 9729.2 8523.9 8540.7 8569.9 8616.3 8733.0 8303.8 8331.4 8424.2 8437.0 8607.8 7733.9 7779.4 7786.9 7832.3 7841.3 5353.1 5377.4 5431.1 5508.9 5574.2 5378.8 5414.9 5488.9 5493.2 5513.3 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#4] prototype.html Cycles:180 Average:5074.42 Median:5642.11 stddev:1514.05 (26.8%) stddev-sans-first:1476.31 01:38:48 INFO - PROCESS | 12941 | Values: 356.8 361.3 368.9 372.2 373.0 5711.5 5797.9 5837.5 5950.6 5966.6 5615.7 5692.5 5716.5 5717.3 5741.7 4426.6 4454.5 4477.4 4486.6 4496.8 4424.2 4464.7 4478.7 4483.6 4491.9 4412.3 4421.6 4428.6 4431.9 4482.5 4471.3 4472.5 4475.3 4515.9 4528.1 3744.6 3913.9 4016.1 4031.4 4047.0 5588.0 5599.9 5664.3 5672.5 5699.9 5219.7 5220.5 5225.3 5248.9 5250.2 6004.9 6051.8 6145.8 6146.4 6166.1 4371.5 4374.8 4389.0 4399.0 4399.5 6331.7 6395.5 6421.1 6450.0 6461.5 4215.3 4447.8 4459.9 4463.2 4472.6 4507.0 4508.2 4545.1 4550.4 4580.6 5212.4 5225.5 5236.8 5241.1 5242.6 5890.2 5954.5 6105.5 6107.5 6108.2 1552.4 1557.1 1570.4 1577.1 1578.8 977.4 985.0 989.6 1004.9 1010.5 5184.7 5269.7 5284.3 5299.0 5338.8 5526.6 5552.6 5582.4 5602.5 5619.9 4937.5 5169.6 5178.7 5270.6 5303.3 2961.1 2994.6 3030.4 3037.6 3057.9 5591.3 5664.7 5700.7 5764.1 5764.4 6023.9 6476.1 6479.3 6487.8 6541.2 6484.7 6505.9 6539.2 6570.5 6585.7 6086.2 6303.3 6335.6 6339.2 6374.8 6238.3 6331.5 6376.4 6376.8 6396.0 6487.7 6543.5 6575.3 6582.3 6589.3 4484.5 4506.8 4509.0 4510.5 4546.0 6162.8 6377.7 6462.4 6463.9 6481.3 6095.3 6142.8 6151.6 6180.8 6219.6 6003.2 6162.4 6187.3 6188.3 6220.3 6022.2 6071.6 6085.7 6115.4 6124.2 6207.2 6208.5 6208.9 6209.3 6251.9 5810.5 6045.5 6049.6 6056.1 6120.6 01:38:48 INFO - PROCESS | 12941 | 01:38:48 INFO - PROCESS | 12941 | [#5] yui.html Cycles:180 Average:21495.83 Median:4786.72 stddev:30740.72 (642.2%) stddev-sans-first:30787.44 01:38:48 INFO - PROCESS | 12941 | Values: 738.7 775.3 824.1 825.0 826.1 15648.8 16265.3 16960.7 16983.3 17059.9 15642.4 15750.4 15761.7 15788.2 15805.9 728.0 842.9 861.1 872.3 877.0 870.0 872.5 875.6 878.3 878.8 916.9 922.0 928.1 928.6 932.0 914.8 915.0 918.5 919.1 921.5 671.6 675.1 675.7 676.5 678.7 15477.5 15488.1 15489.7 15519.4 15534.0 13588.9 14025.1 14108.0 14530.2 15800.0 14066.7 14135.9 14148.0 14165.4 14256.1 4687.8 4714.6 4780.6 4792.9 4800.0 73981.3 82514.6 82608.0 82971.6 83470.6 12117.3 12619.1 12632.5 12689.4 12798.6 22449.6 22608.2 22635.1 22699.7 22717.4 9168.0 9190.4 9239.4 9460.3 9510.0 4942.5 5056.4 5145.0 5171.5 5232.4 3915.9 4007.1 4030.0 4120.6 4344.0 681.6 686.6 688.9 694.0 704.6 805.5 817.2 824.0 831.2 852.8 10559.9 10788.0 10867.0 10892.2 10953.7 752.7 799.5 806.7 808.6 814.1 4937.7 4988.8 4999.1 5094.8 5098.2 84176.0 118844.0 135098.0 137506.0 138005.0 90463.0 91363.0 96971.5 103059.5 106441.0 76321.0 80517.0 81108.6 90479.0 94206.0 9027.7 9028.7 9266.6 9335.8 9374.1 45047.8 45830.3 51714.5 51759.7 53559.7 67387.0 69609.7 77616.2 78720.0 79341.0 12957.4 13200.4 13249.3 13483.8 13756.5 15188.5 15301.2 15378.2 15941.8 16043.8 13955.2 14093.0 14142.2 14388.9 14402.9 14494.0 14752.4 14910.6 15032.8 15467.5 14872.7 14987.6 15120.5 15386.8 15511.1 11216.4 11342.7 11571.5 11616.4 11617.1 11609.7 11788.2 11839.7 11869.3 11873.4 01:38:48 INFO - PROCESS | 12941 | -------- Summary: end -------- 01:38:48 INFO - PROCESS | 12941 | 01:38:49 INFO - TEST-INFO | 12941: exit 0 01:38:49 INFO - TEST-OK | dromaeo_css | took 1110126ms 01:38:49 INFO - TEST-START | kraken 01:38:49 INFO - operating with platform_type : linux_ 01:38:49 INFO - Initialising browser for kraken test... 01:38:49 INFO - TEST-INFO | started process 13185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3PYVY/profile http://localhost:41574/getInfo.html) 01:38:53 INFO - PROCESS | 13185 | __metrics Screen width/height:1600/1200 01:38:53 INFO - PROCESS | 13185 | colorDepth:24 01:38:53 INFO - PROCESS | 13185 | Browser inner width/height: 1024/697 01:38:53 INFO - PROCESS | 13185 | __metrics 01:38:54 ERROR - PROCESS | 13185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:38:55 INFO - TEST-INFO | 13185: exit 0 01:38:55 INFO - Browser initialized. 01:38:55 INFO - Running cycle 1/1 for kraken test... 01:38:55 INFO - TEST-INFO | started process 13310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3PYVY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:07 INFO - PROCESS | 13310 | RSS: Main: 156033024 01:39:07 INFO - PROCESS | 13310 | 01:39:09 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41574/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:10 INFO - PROCESS | 13310 | RSS: Main: 161226752 01:39:10 INFO - PROCESS | 13310 | 01:39:13 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41574/tests/kraken/driver.html?testName=audio-dft) 01:39:13 INFO - PROCESS | 13310 | RSS: Main: 160223232 01:39:13 INFO - PROCESS | 13310 | 01:39:16 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41574/tests/kraken/driver.html?testName=audio-fft) 01:39:17 INFO - PROCESS | 13310 | RSS: Main: 161304576 01:39:17 INFO - PROCESS | 13310 | 01:39:19 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41574/tests/kraken/driver.html?testName=audio-oscillator) 01:39:19 INFO - PROCESS | 13310 | RSS: Main: 160985088 01:39:19 INFO - PROCESS | 13310 | 01:39:22 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:22 INFO - PROCESS | 13310 | RSS: Main: 160755712 01:39:22 INFO - PROCESS | 13310 | 01:39:25 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41574/tests/kraken/driver.html?testName=imaging-darkroom) 01:39:26 INFO - PROCESS | 13310 | RSS: Main: 160079872 01:39:26 INFO - PROCESS | 13310 | 01:39:29 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41574/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:30 INFO - PROCESS | 13310 | RSS: Main: 161198080 01:39:30 INFO - PROCESS | 13310 | 01:39:33 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41574/tests/kraken/driver.html?testName=json-parse-financial) 01:39:33 INFO - PROCESS | 13310 | RSS: Main: 161595392 01:39:33 INFO - PROCESS | 13310 | 01:39:35 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:39:35 INFO - PROCESS | 13310 | RSS: Main: 160944128 01:39:35 INFO - PROCESS | 13310 | 01:39:37 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:39:38 INFO - PROCESS | 13310 | RSS: Main: 161009664 01:39:38 INFO - PROCESS | 13310 | 01:39:40 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:39:40 INFO - PROCESS | 13310 | RSS: Main: 161079296 01:39:40 INFO - PROCESS | 13310 | 01:39:43 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:44 INFO - PROCESS | 13310 | RSS: Main: 161632256 01:39:44 INFO - PROCESS | 13310 | 01:39:46 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:47 INFO - PROCESS | 13310 | RSS: Main: 161308672 01:39:47 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | Cycle 1(1): loaded http://localhost:41574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41574/tests/kraken/driver.html?testName=ai-astar) 01:39:49 INFO - PROCESS | 13310 | RSS: Main: 161873920 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | __start_tp_report 01:39:49 INFO - PROCESS | 13310 | _x_x_mozilla_page_load 01:39:49 INFO - PROCESS | 13310 | _x_x_mozilla_page_load_details 01:39:49 INFO - PROCESS | 13310 | |i|pagename|runs| 01:39:49 INFO - PROCESS | 13310 | |0;ai-astar;110;104;110;109;111;110;110;110;111;109 01:39:49 INFO - PROCESS | 13310 | |1;audio-beat-detection;147;125;161;181;130;157;149;133;197;129 01:39:49 INFO - PROCESS | 13310 | |2;audio-dft;162;162;164;163;160;164;164;160;165;160 01:39:49 INFO - PROCESS | 13310 | |3;audio-fft;75;76;74;169;76;76;75;74;169;76 01:39:49 INFO - PROCESS | 13310 | |4;audio-oscillator;84;85;151;86;84;86;145;86;85;143 01:39:49 INFO - PROCESS | 13310 | |5;imaging-gaussian-blur;117;118;117;117;117;116;117;117;117;117 01:39:49 INFO - PROCESS | 13310 | |6;imaging-darkroom;147;146;148;147;147;148;147;148;147;148 01:39:49 INFO - PROCESS | 13310 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;95;96 01:39:49 INFO - PROCESS | 13310 | |8;json-parse-financial;54;52;52;51;56;53;52;50;52;60 01:39:49 INFO - PROCESS | 13310 | |9;json-stringify-tinderbox;60;60;60;60;60;60;59;59;61;61 01:39:49 INFO - PROCESS | 13310 | |10;stanford-crypto-aes;78;80;75;76;77;77;78;79;119;78 01:39:49 INFO - PROCESS | 13310 | |11;stanford-crypto-ccm;132;120;130;129;137;118;130;128;125;120 01:39:49 INFO - PROCESS | 13310 | |12;stanford-crypto-pbkdf2;153;155;155;159;154;154;155;154;153;156 01:39:49 INFO - PROCESS | 13310 | |13;stanford-crypto-sha256-iterative;68;60;62;64;64;65;64;61;62;62 01:39:49 INFO - PROCESS | 13310 | __end_tp_report 01:39:49 INFO - PROCESS | 13310 | __start_cc_report 01:39:49 INFO - PROCESS | 13310 | _x_x_mozilla_cycle_collect,863 01:39:49 INFO - PROCESS | 13310 | __end_cc_report 01:39:49 INFO - PROCESS | 13310 | __startTimestamp1467103189312__endTimestamp 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | ------- Summary: start ------- 01:39:49 INFO - PROCESS | 13310 | Number of tests: 14 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 01:39:49 INFO - PROCESS | 13310 | Values: 110.0 104.0 110.0 109.0 111.0 110.0 110.0 110.0 111.0 109.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:153.00 stddev:23.80 (15.6%) stddev-sans-first:25.20 01:39:49 INFO - PROCESS | 13310 | Values: 147.0 125.0 161.0 181.0 130.0 157.0 149.0 133.0 197.0 129.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 01:39:49 INFO - PROCESS | 13310 | Values: 162.0 162.0 164.0 163.0 160.0 164.0 164.0 160.0 165.0 160.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.54 (52.4%) stddev-sans-first:41.33 01:39:49 INFO - PROCESS | 13310 | Values: 75.0 76.0 74.0 169.0 76.0 76.0 75.0 74.0 169.0 76.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:29.63 (34.9%) stddev-sans-first:30.58 01:39:49 INFO - PROCESS | 13310 | Values: 84.0 85.0 151.0 86.0 84.0 86.0 145.0 86.0 85.0 143.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:39:49 INFO - PROCESS | 13310 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:39:49 INFO - PROCESS | 13310 | Values: 147.0 146.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:39:49 INFO - PROCESS | 13310 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:52.50 stddev:2.90 (5.5%) stddev-sans-first:3.06 01:39:49 INFO - PROCESS | 13310 | Values: 54.0 52.0 52.0 51.0 56.0 53.0 52.0 50.0 52.0 60.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 01:39:49 INFO - PROCESS | 13310 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 59.0 59.0 61.0 61.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:78.00 stddev:13.18 (16.9%) stddev-sans-first:13.91 01:39:49 INFO - PROCESS | 13310 | Values: 78.0 80.0 75.0 76.0 77.0 77.0 78.0 79.0 119.0 78.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.50 stddev:6.06 (4.7%) stddev-sans-first:6.14 01:39:49 INFO - PROCESS | 13310 | Values: 132.0 120.0 130.0 129.0 137.0 118.0 130.0 128.0 125.0 120.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:1.75 (1.1%) stddev-sans-first:1.73 01:39:49 INFO - PROCESS | 13310 | Values: 153.0 155.0 155.0 159.0 154.0 154.0 155.0 154.0 153.0 156.0 01:39:49 INFO - PROCESS | 13310 | 01:39:49 INFO - PROCESS | 13310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:2.30 (3.6%) stddev-sans-first:1.66 01:39:49 INFO - PROCESS | 13310 | Values: 68.0 60.0 62.0 64.0 64.0 65.0 64.0 61.0 62.0 62.0 01:39:49 INFO - PROCESS | 13310 | -------- Summary: end -------- 01:39:49 INFO - PROCESS | 13310 | 01:39:50 INFO - TEST-INFO | 13310: exit 0 01:39:50 INFO - TEST-OK | kraken | took 60824ms 01:39:50 INFO - SUITE-END | took 1170s 01:39:50 INFO - Completed test suite (00:19:31) 01:39:50 INFO - javascript benchmark 01:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7894.536077784083, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.677030682085, 3455.032590874556, 3461.6192218855936, 3468.4277094279446, 3477.0, 5804.941950580493, 5824.155497452867, 5833.445822646847, 5833.912491312633, 5926.081457374103, 5788.42115788421, 5866.530677545797, 5870.589058765888, 5879.0593505039205, 5919.904817608745, 5235.712035838027, 5320.334958130234, 5354.892902141974, 5364.275822763935, 5377.193420986844, 5291.947080529184, 5293.179557168645, 5314.149736042234, 5400.972995135019, 5402.648827826199, 5287.233351164079, 5304.893902121975, 5305.946940530604, 5317.813876514323, 5441.564674826024, 5374.462553744634, 5386.542143917772, 5397.217403476474, 5398.433164517748, 5418.512333889968, 5113.079645663779, 5204.843854684365, 5210.478952104797, 5264.42091369949, 5353.491418315254, 5702.857428564277, 5780.682062486561, 5814.447627475383, 5828.9417105828825, 5857.4435428634215, 6243.65659888706, 6312.747490100391, 6342.175517182783, 6351.110844481776, 6365.522585806083, 6113.597930965863, 6187.535934804862, 6200.503959683215, 6374.171357723512, 6406.007068904327, 5900.675462849585, 5900.734466948998, 5901.527877769811, 5910.615809972338, 5911.733971971272, 6445.387688169616, 6463.676816159267, 6472.838179045561, 6479.125318082093, 6485.092087107809, 5848.561357898175, 6029.8191054268445, 6050.606710563799, 6078.908816367758, 6202.317745048132, 6199.485122433049, 6207.0, 6224.688765561704, 6252.968735156295, 6253.468455181361, 6210.285817130997, 6212.968935155386, 6214.533909956771, 6218.875622487525, 6243.219597550306, 6000.669963151981, 6125.296497837281, 6135.07973803933, 6146.016637338004, 6250.562460627803, 4698.577128058491, 4720.409948756405, 4729.55069268419, 4734.171519983989, 4734.55021772931, 4119.855805046809, 4196.727212731163, 4238.173556156582, 4244.129953359616, 4245.3844192591905, 5792.391798861143, 5881.264841894763, 5925.288965324103, 5971.343152253248, 5998.190244316961, 6200.627962322275, 6214.161088253119, 6242.531810114259, 6246.063090536456, 6274.780382686676, 6016.578839481282, 6017.608855424383, 6034.2155519782145, 6076.969615151896, 6097.817065488042, 5228.686278823283, 5312.548433383128, 5328.893422131536, 5371.865703357447, 5380.300560927133, 6459.0, 6505.0, 6514.771982980573, 6524.771632992917, 6525.934740652628, 6106.450419462092, 6392.936070639327, 6394.840128996812, 6401.487880969418, 6403.103565500926, 6291.685415729104, 6337.493000560036, 6356.713947872265, 6415.069814876723, 6421.614703117828, 6171.59884607499, 6180.072989051679, 6182.598131121643, 6184.5980011299125, 6191.597546159485, 6125.601835880653, 6183.350748171377, 6300.810975670737, 6304.810855674337, 6306.779262725782, 6025.457708806229, 6146.139540464249, 6158.414950579688, 6173.9073913892225, 6190.783322583688, 6116.0, 6119.84700382494, 6143.447089761943, 6157.0, 6185.597936134137, 5831.679257640871, 5983.0, 6006.8498287541415, 6060.575759696779, 6114.266288045463, 6135.693215339126, 6206.503479721701, 6212.099245609452, 6218.098375735583, 6228.875422491434, 6047.727852246748, 6060.848478788065, 6080.473325471305, 6101.054336577838, 6124.350421260821], "value": 5768.150845682316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7337824600684, 641.5412979719499, 645.5223134880188, 648.8961766117422, 651.3746803069055, 48118.0, 50074.749626251905, 50186.24720629193, 50264.0, 52508.737456312665, 50152.74923625386, 50463.495365046336, 50758.0, 50782.49217507824, 50862.49137508624, 9277.489738064403, 9377.296702747288, 9402.858957115615, 9412.058794120601, 9448.574814133346, 9081.046490118542, 9177.219936305388, 9205.631774729036, 9234.86147707785, 9267.119623635745, 9181.540922953825, 9280.396774209688, 9286.442813431217, 9292.070792920722, 9295.39579927306, 9214.631414743402, 9259.722208333727, 9261.120193581599, 9275.768105797375, 9306.302027347976, 9159.221466175382, 9201.631934722604, 9231.39995900271, 9231.815363692756, 9233.07669233078, 45923.311150332775, 46631.300530492066, 46695.0, 46801.0, 46801.5319846804, 3759.9248015039548, 3908.472356231901, 3921.137349783043, 3953.4860468139245, 4037.2732908076537, 35995.64004359949, 36372.63627363719, 36523.0, 36530.81734591337, 37000.629993699986, 4633.0, 4667.813287468532, 4712.363830882821, 4726.7400292983875, 4774.355462012653, 405714.0, 406400.0, 408190.0, 408234.0, 408982.99999999703, 70304.0, 70689.29310706827, 71019.28980710126, 71190.64404677943, 71359.64320178366, 40323.395149072785, 41342.1731565367, 41425.0, 43167.56832431635, 43510.69467915968, 19942.0, 19996.100175492138, 20042.89978550127, 20092.59814803696, 20096.19615215375, 15444.0, 15583.376664933276, 15585.532434026998, 15596.766048509282, 15642.296096675676, 21811.23660671869, 22451.32646020589, 22462.0, 22525.662115068288, 22535.549289014456, 7513.173550909396, 7790.922090779133, 7927.84144317122, 8034.638441270157, 8056.8388632227025, 1043.7583252152172, 1113.2263077161458, 1140.156284349592, 1178.9742923656474, 1218.7318789866215, 33802.66197338044, 34194.48708269378, 34342.65657343445, 34403.635550920364, 34563.82718086393, 1168.1822724093, 1191.0888170549536, 1197.245735186844, 1222.743223922986, 1235.8393408856791, 17903.836250643668, 18107.637847242982, 18214.33183981257, 18308.084595770157, 18373.908130459262, 715833.0, 725493.0, 728299.0, 931539.0, 1077152.0, 65524.0, 65607.0, 65801.67099164473, 65943.0, 66011.0, 1399.6221020324658, 1400.824896887889, 1440.0135906903595, 1446.3925151436422, 1514.1142431677372, 33006.669933300356, 33710.49434258537, 33890.68581766335, 33996.66003339935, 34475.0, 56790.716046419504, 56824.71587642201, 57360.42639573551, 57413.425865740806, 57418.0, 424864.0, 427409.0, 428640.0, 428886.0, 429458.0, 30736.23159420943, 31184.22039449032, 31207.219819504695, 31287.687123129388, 32415.35169296648, 54576.72711636416, 54664.72667636796, 54737.0, 55520.44479555153, 56164.0, 46117.76941115273, 47109.7644511789, 47887.521124788305, 48008.0, 48209.75895120502, 46946.0, 47012.52987470081, 47243.763781180875, 47363.28955065746, 47579.52420475889, 43747.34378984254, 43769.34345984749, 43817.34273985829, 46395.10878195881, 46588.53411465842, 38994.80502597469, 40949.38575921423, 41043.79478102591, 41682.37476437795, 41949.37075943924, 35818.925432237076, 36737.44422149643, 39135.0, 39410.605893940694, 39992.8000360008], "value": 22304.990389551265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.51181141687067, 429.46317103620476, 434.5567521128449, 439.30370362974685, 452.934324522944, 18693.906530467346, 20478.385648430532, 21079.578408431822, 21325.786742132575, 21520.569588608258, 19665.60668786627, 19929.302474413398, 20663.690044649342, 20687.37937861863, 20693.0, 5834.095715164146, 5992.5505587080925, 6016.42843929826, 6020.879582408349, 6037.7584896604085, 5684.261046064026, 5887.058070708687, 5916.497097746696, 5959.374265702104, 5962.04607262838, 5897.793577224798, 5903.3211180714125, 5905.055191169414, 5923.644581325113, 5941.643501389931, 5685.204071430003, 5869.325027621835, 5910.143029260755, 5911.615744976562, 5922.052471604566, 5257.474252574751, 5300.734963251822, 5312.92030619541, 5336.599755018389, 5348.812791552277, 24407.511849763083, 24491.87754061236, 24648.753512464824, 24654.383640408952, 24742.134025309027, 2498.650188973545, 2576.330154159932, 2595.8053146014126, 2607.2178346495975, 2743.1359121876544, 15220.467283645019, 15593.92203038989, 15700.68598628021, 15755.921220393939, 15797.92101039499, 2021.2319318658815, 2056.259746491262, 2097.265956915083, 2131.8507704460694, 2183.617866873291, 81329.0, 84423.0, 84508.57745711232, 84890.57554712187, 85511.0, 10941.4529273536, 11318.26431281964, 11602.0, 11691.415429228504, 11778.293302401884, 16179.595510112342, 16274.918625406797, 16304.836951630568, 16313.836861631231, 16397.836021639632, 8395.790105247295, 8627.568621568897, 8682.175193356747, 8773.38586298953, 8794.34042446819, 8328.375371847136, 8490.236228337339, 8840.115988401109, 9167.541622918961, 9209.493477858781, 6864.5881247125335, 6963.1296087989, 6972.895406568906, 6998.020277161201, 7128.572285662877, 2048.754149502069, 2098.8320934325216, 2099.4016705238932, 2104.5054412213117, 2152.160657343637, 1037.3361048928691, 1074.4788777442934, 1115.7545340025345, 1132.4111462039857, 1182.7634473105413, 18168.45494635163, 19968.500787480138, 20292.18831246763, 20359.796402036085, 20675.689864652042, 1080.6920027792041, 1080.8324709670014, 1101.763120928988, 1102.388174563109, 1140.441183819939, 11556.76886462266, 11819.468123934443, 11877.643670689893, 11960.222585532087, 12118.333491657868, 463826.0, 464708.0, 465826.0, 466609.0, 489495.0, 49890.25164622533, 66897.66551167212, 74758.62620686862, 78449.60775196088, 85602.14397855941, 1106.3306699446719, 1114.0474893965866, 1156.5720683347215, 1167.795635763738, 1187.958421455245, 18276.45170644883, 18744.343947961755, 18797.154128064543, 18985.620287593894, 19004.71492927635, 41301.0, 41733.0, 42301.36547951845, 42580.36129457998, 43133.784331078146, 62131.689341553, 64006.0, 66128.0, 66166.33833661601, 66548.0, 9085.77285567866, 9268.536573171179, 9278.675246366345, 9293.070692930653, 9323.953380233055, 13289.867101328862, 13918.0, 14383.208923509308, 14404.42382304696, 14722.705545888808, 12557.560485382968, 12560.811587826007, 12568.245905245349, 12637.2417654941, 12683.619491415273, 11949.163558551165, 12065.638030859089, 12195.878041219474, 12797.744045119232, 12880.677983050498, 12232.0, 12233.69415764613, 12300.323482208565, 12521.624351269476, 13041.934790326368, 9045.864312035457, 9095.454272743656, 9272.350935434724, 9287.674931377369, 9360.391574547633, 9586.952065239908, 12755.93622031884, 12785.808212877, 12795.872041279841, 12849.164804287691], "value": 9905.570086319634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.589623749706, 1603.0782300177398, 1777.8933264004152, 1898.392514395394, 1898.667733146699, 8464.492130472176, 9159.40463869848, 9224.21594164496, 9885.308028438012, 9893.208543316545, 8908.554572271376, 9187.127222913829, 9234.584443700032, 9251.768705782359, 9289.953550232256, 2532.898684052636, 2543.8855251513633, 2570.9357266068405, 2573.562494375961, 2574.04760238711, 2441.401856545149, 2517.7230504644567, 2519.5842685956886, 2519.6976362836485, 2522.3441905104623, 2455.8403703759286, 2487.0, 2536.264483299841, 2538.2512158913164, 2544.860032698201, 2470.28361775085, 2501.562226610345, 2506.4611108611552, 2512.811539134563, 2535.3408113890337, 2497.675302210701, 2504.511620234055, 2520.483300923325, 2522.7981761459223, 2523.9242822715164, 9846.310758246926, 9869.950650246774, 9882.604695812159, 9913.058259465339, 9920.801583968352, 5891.558133139989, 5901.085331773582, 5974.820755377302, 5989.8203053908455, 6029.54778391618, 3575.2670702505925, 3600.063983364344, 3712.814359282052, 3779.4708740776314, 3819.8281077351585, 1208.7456892894777, 1217.2392254840724, 1244.9066320026034, 1252.7118762684543, 1261.6467389131058, 13229.999999999904, 13243.20540767557, 13258.138221015699, 13259.867401326057, 13488.797668034988, 4986.351774269394, 5001.8499445016705, 5114.0, 5154.974225128925, 5169.767360468788, 11042.447877606088, 11114.0, 11149.72125696864, 11152.665420037412, 11181.83227251592, 5873.0, 5873.236479257669, 5879.265091863517, 5883.499902508249, 5899.882002359929, 4724.905501889943, 5380.677159370451, 5415.133578627479, 5461.863453413617, 5505.421930697299, 4418.5802348776815, 4450.888727781831, 4457.398251236042, 4459.732416055047, 4476.082403107355, 1403.6701375176826, 1432.10493441599, 1442.6321288071474, 1443.6390902274431, 1463.0563286680033, 918.6784625381197, 994.627014869424, 1037.1754455208127, 1045.7751583409604, 1080.152080616712, 6309.08518264849, 6438.806835794933, 6601.70292336846, 6636.336366363325, 6840.589564626139, 1003.5584342889106, 1043.6555936540924, 1054.1250761867784, 1066.9039786419105, 1088.689723428819, 4536.4102666653125, 4541.9545804542195, 4578.381918441034, 4592.173408786383, 4596.908061838744, 12121.878781212252, 12465.18976266558, 12822.422990965242, 12840.55058072963, 12843.165194262343, 12405.379731013414, 12806.167599106027, 12918.289494077915, 12926.289054101926, 12957.157784743962, 8945.507997060095, 9045.592948317342, 9098.590563424661, 9103.999999999867, 9146.908530914605, 6339.904901426575, 6436.195475565554, 6483.384078512534, 6575.736970521126, 6615.073889655549, 11003.669889903316, 11032.724181895517, 11422.600208992646, 11694.415279236175, 11752.823707644222, 11535.307881527135, 11576.36330001858, 11894.940525297665, 11982.10134239918, 12051.0, 7796.259355361231, 8338.166183381856, 8488.278496327634, 8629.180227878342, 8785.736427907173, 9616.95191524038, 9631.373960692532, 9671.032896710272, 9688.70933871985, 9729.22166226686, 8523.914760852313, 8540.70107546233, 8569.914300856912, 8616.267617252353, 8733.039365669643, 8303.750887473385, 8331.375146863887, 8424.157584241526, 8437.0, 8607.784805379915, 7733.883991740241, 7779.416543759354, 7786.88319675194, 7832.2559356863285, 7841.255080767546, 5353.143497040455, 5377.3816011159215, 5431.103867861917, 5508.862278443071, 5574.219609254626, 5378.757955891916, 5414.945850541601, 5488.890222195613, 5493.176023596492, 5513.3108361454815], "value": 5120.251092390659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.8287222133376, 361.2720368457558, 368.85983326336, 372.2090557565174, 372.983215755291, 5711.485966263035, 5797.927383434067, 5837.503812175964, 5950.642961422318, 5966.642001479914, 5615.7472913718875, 5692.5161361284345, 5716.456936591017, 5717.285339332583, 5741.712914354286, 4426.601605855472, 4454.507739907127, 4477.3731677565165, 4486.641068714495, 4496.842610508633, 4424.181526417607, 4464.732116073046, 4478.73823719023, 4483.5516448355065, 4491.887702807423, 4412.338149277602, 4421.557844215568, 4428.623566996809, 4431.936335279542, 4482.529334419888, 4471.262241730127, 4472.5303843096335, 4475.261581838992, 4515.864524064284, 4528.139653465831, 3744.5506539215467, 3913.9217215655813, 4016.136530645896, 4031.3751368537924, 4047.0, 5587.9941610510095, 5599.8880022399735, 5664.348599911022, 5672.5178359839465, 5699.943000569982, 5219.660722053092, 5220.477952204749, 5225.346831646044, 5248.921266181011, 5250.159974404115, 6004.879902401927, 6051.788187413464, 6145.770845830852, 6146.35463276354, 6166.136740856284, 4371.453568303962, 4374.759388233646, 4388.978055109704, 4399.0, 4399.450068741407, 6331.68341582919, 6395.488360931115, 6421.133147025185, 6449.96775016122, 6461.5153863459955, 4215.3044747616295, 4447.822087116544, 4459.888502787457, 4463.24124898768, 4472.642188624902, 4507.0, 4508.233600287894, 4545.090981803586, 4550.431196100488, 4580.625812256377, 5212.400573934046, 5225.4774522548205, 5236.764345604457, 5241.0828105081455, 5242.633015688942, 5890.175375447441, 5954.523638108941, 6105.542084343692, 6107.541934354941, 6108.205933228652, 1552.4023251048202, 1557.0813220200137, 1570.4267942201013, 1577.085290531489, 1578.8105427348792, 977.359829311802, 984.9507524623883, 989.6239429017071, 1004.9196064314838, 1010.4745532323151, 5184.714840683799, 5269.736513174326, 5284.313039304866, 5299.019681358961, 5338.839834804962, 5526.58550608706, 5552.639078459968, 5582.381109478206, 5602.487328421304, 5619.880966063792, 4937.530934561211, 5169.578365949394, 5178.715170665574, 5270.552003079782, 5303.28405665238, 2961.0672638119354, 2994.625671791026, 3030.3636236390166, 3037.635483741921, 3057.92355191122, 5591.329040515164, 5664.660120392789, 5700.714964251771, 5764.106563482667, 5764.394738552475, 6023.909641355383, 6476.114331401216, 6479.254885688112, 6487.772927947499, 6541.182352205974, 6484.708188131545, 6505.934940650627, 6539.182602174728, 6570.507211959122, 6585.7487077455135, 6086.178365920544, 6303.275123360872, 6335.556511044183, 6339.175907132043, 6374.808755737336, 6238.315654773277, 6331.461825744863, 6376.39424254695, 6376.840578985562, 6396.0, 6487.675616219264, 6543.5419520635005, 6575.309592492719, 6582.308857570078, 6589.308122647053, 4484.484284307347, 4506.774661266858, 4508.977455112704, 4510.548945105464, 4545.954540454685, 6162.845928851814, 6377.7130029147875, 6462.4183823456115, 6463.935360646521, 6481.319461456479, 6095.299040610209, 6142.846428839315, 6151.6001459904965, 6180.7527698891545, 6219.564630476004, 6003.189569408074, 6162.442586326624, 6187.257529096537, 6188.319284878569, 6220.25832766826, 6022.247219097613, 6071.633882376606, 6085.69571521431, 6115.388461153849, 6124.203853499017, 6207.16203312547, 6208.50331973432, 6208.906866397098, 6209.285932117864, 6251.874962500816, 5810.477057064884, 6045.486133678686, 6049.576529642883, 6056.121862330026, 6120.632762034292], "value": 4592.738516289481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.6860584251692, 775.3254668438459, 824.0688022534536, 825.030589057857, 826.1119296755988, 15648.765268520967, 16265.34938602456, 16960.660786784258, 16983.320667173328, 17059.91470042651, 15642.374305027784, 15750.448734294301, 15761.684766304666, 15788.210589470538, 15805.920970395133, 727.9636018199095, 842.9157084291552, 861.0958493581729, 872.2672954718035, 876.9736907892774, 870.0342619692136, 872.4808738800403, 875.5622188905547, 878.2841983783228, 878.7627340618029, 916.8991410944791, 922.0226559846584, 928.0951072704094, 928.5821380378823, 932.0493097041015, 914.7575892388522, 915.0026471146416, 918.5131880103556, 919.1497864475367, 921.5069937583428, 671.5735507952437, 675.1459403854079, 675.746595026865, 676.5433332500543, 678.6911955060435, 15477.5356739298, 15488.148151851643, 15489.690206195926, 15519.379224831106, 15534.0, 13588.93205533966, 14025.088369255966, 14108.0, 14530.200838953853, 15800.0, 14066.71866562663, 14135.85864141366, 14148.0, 14165.362558684885, 14256.073355231876, 4687.812487500496, 4714.622830173578, 4780.593649539794, 4792.856214313576, 4799.976000120012, 73981.26018739743, 82514.58742706248, 82608.0, 82971.5851420745, 83470.58264708638, 12117.27296362221, 12619.116661833767, 12632.494700211888, 12689.365531723377, 12798.552050678181, 22449.551008979728, 22608.208712694977, 22635.094596216295, 22699.659505107436, 22717.43206419853, 9167.95416022929, 9190.356675032683, 9239.39943903644, 9460.337776355727, 9510.001449847805, 4942.5057494251005, 5056.387041450212, 5144.9742751286, 5171.534561889448, 5232.372115346183, 3915.92168156641, 4007.0984028593916, 4029.9798501007895, 4120.62914337711, 4344.022594916119, 681.6012632609879, 686.5708931917552, 688.8691148681735, 694.0283602955801, 704.5913370245246, 805.4764403138007, 817.1746535998684, 823.9629216685144, 831.1729828820362, 852.7825404521807, 10559.947200264103, 10788.0, 10867.021968022758, 10892.183086268562, 10953.726156845983, 752.7177308509309, 799.4883274704194, 806.7136166660869, 808.6441965535263, 814.1329484099415, 4937.746405021822, 4988.7505624718615, 4999.125153098266, 5094.770735316845, 5098.158803797406, 84176.0, 118844.0, 135098.0, 137506.0, 138005.0, 90463.0, 91363.0, 96971.51514242384, 103059.48470257751, 106441.0, 76320.9999999989, 80517.0, 81108.59445702734, 90479.0, 94206.0, 9027.729168124966, 9028.683996060106, 9266.583003764981, 9335.813283734424, 9374.109459601326, 45047.774761125984, 45830.31254531251, 51714.48285517247, 51759.70600735012, 53559.7322013403, 67387.0, 69609.65195173991, 77616.22383776316, 78720.0, 79341.0, 12957.41691623898, 13200.405981730653, 13249.337533123113, 13483.797743034058, 13756.518521851687, 15188.46840360582, 15301.234938253265, 15378.154201518577, 15941.840581594035, 16043.759343609621, 13955.232462214675, 14093.0, 14142.22217778032, 14388.856111438752, 14402.927985360006, 14494.0, 14752.409903603735, 14910.552683419515, 15032.774508382601, 15467.5359739208, 14872.702545948803, 14987.550373488813, 15120.470783522524, 15386.769198461809, 15511.146886921328, 11216.383098929637, 11342.716432089264, 11571.479283432434, 11616.361100139573, 11617.128715346551, 11609.709757256136, 11788.174827762317, 11839.704007399883, 11869.287842729464, 11873.400834304115], "value": 8076.754909974874, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 161.0, 181.0, 130.0, 157.0, 149.0, 133.0, 197.0, 129.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 160.0, 164.0, 164.0, 160.0, 165.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 169.0, 76.0, 76.0, 75.0, 74.0, 169.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 151.0, 86.0, 84.0, 86.0, 145.0, 86.0, 85.0, 143.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 51.0, 56.0, 53.0, 52.0, 50.0, 52.0, 60.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 75.0, 76.0, 77.0, 77.0, 78.0, 79.0, 119.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 120.0, 130.0, 129.0, 137.0, 118.0, 130.0, 128.0, 125.0, 120.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 155.0, 159.0, 154.0, 154.0, 155.0, 154.0, 153.0, 156.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 60.0, 62.0, 64.0, 64.0, 65.0, 64.0, 61.0, 62.0, 62.0], "value": 63.2, "unit": "score"}]}]} 01:39:50 INFO - Return code: 0 01:39:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:50 ERROR - # TBPL SUCCESS # 01:39:50 INFO - Running post-action listener: _resource_record_post_action 01:39:50 INFO - ##### 01:39:50 INFO - ##### Finished run-tests step (success) 01:39:50 INFO - ##### 01:39:50 INFO - Running post-run listener: _resource_record_post_run 01:39:50 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 614400; Write bytes: 255631360; Read time: 180; Write time: 178092 01:39:50 INFO - TinderboxPrint: CPU usage
13.4% 01:39:50 INFO - TinderboxPrint: I/O read bytes / time
614,400 / 180 01:39:50 INFO - TinderboxPrint: I/O write bytes / time
255,631,360 / 178,092 01:39:50 INFO - TinderboxPrint: CPU idle
8,210.6 (86.6%) 01:39:50 INFO - TinderboxPrint: CPU user
1,213.8 (12.8%) 01:39:50 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5169152; Read time: 0; Write time: 336 01:39:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 614400; Write bytes: 250462208; Read time: 180; Write time: 177756 01:39:51 INFO - Running post-run listener: _upload_blobber_files 01:39:51 INFO - Blob upload gear active. 01:39:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:51 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:51 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:51 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:52 INFO - (blobuploader) - INFO - Done attempting. 01:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:56 INFO - (blobuploader) - INFO - Done attempting. 01:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:57 INFO - (blobuploader) - INFO - Done attempting. 01:39:57 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:57 INFO - Return code: 0 01:39:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d307cca0e80a09709f975fa50688e6b800c9e31d549dd7bcdd160bbeeda9b5a158a9d41fb64ce14a13203de9d4cc8bf4c50af2f10b6b648699be58b8155dbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba92e4e21c37d37cacf41f152cfb99013a19b24000ac0cc9b82de37a3b8c3bc5dedbd1da9705fe7841cb9a4c85c7046bbffa8bfeaf6597ffc8b07746c5fedf87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd194a2ca29c33174c87827db7780d58bffca18c1e9d843f127cd6b8a4e559c65a75d73e6e82cc9d4215a649088e1258bbdf536e0b7e576e37cf2c994a165e92"} 01:39:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:57 INFO - Contents: 01:39:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96d307cca0e80a09709f975fa50688e6b800c9e31d549dd7bcdd160bbeeda9b5a158a9d41fb64ce14a13203de9d4cc8bf4c50af2f10b6b648699be58b8155dbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba92e4e21c37d37cacf41f152cfb99013a19b24000ac0cc9b82de37a3b8c3bc5dedbd1da9705fe7841cb9a4c85c7046bbffa8bfeaf6597ffc8b07746c5fedf87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd194a2ca29c33174c87827db7780d58bffca18c1e9d843f127cd6b8a4e559c65a75d73e6e82cc9d4215a649088e1258bbdf536e0b7e576e37cf2c994a165e92"} 01:39:57 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:57 INFO - Copying logs to upload dir... 01:39:57 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.906594 ========= master_lag: 283.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 0 secs) (at 2016-06-28 01:44:41.190581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:44:41.193927) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 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/96d307cca0e80a09709f975fa50688e6b800c9e31d549dd7bcdd160bbeeda9b5a158a9d41fb64ce14a13203de9d4cc8bf4c50af2f10b6b648699be58b8155dbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba92e4e21c37d37cacf41f152cfb99013a19b24000ac0cc9b82de37a3b8c3bc5dedbd1da9705fe7841cb9a4c85c7046bbffa8bfeaf6597ffc8b07746c5fedf87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd194a2ca29c33174c87827db7780d58bffca18c1e9d843f127cd6b8a4e559c65a75d73e6e82cc9d4215a649088e1258bbdf536e0b7e576e37cf2c994a165e92"} 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.011302 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/96d307cca0e80a09709f975fa50688e6b800c9e31d549dd7bcdd160bbeeda9b5a158a9d41fb64ce14a13203de9d4cc8bf4c50af2f10b6b648699be58b8155dbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba92e4e21c37d37cacf41f152cfb99013a19b24000ac0cc9b82de37a3b8c3bc5dedbd1da9705fe7841cb9a4c85c7046bbffa8bfeaf6597ffc8b07746c5fedf87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd194a2ca29c33174c87827db7780d58bffca18c1e9d843f127cd6b8a4e559c65a75d73e6e82cc9d4215a649088e1258bbdf536e0b7e576e37cf2c994a165e92"}' ========= master_lag: 0.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:44:41.440885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:44:41.441166) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467101416.55354-2102431852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:44:41.787755) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:44:41.788078) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:44:44.127686) ========= ========= Total master_lag: 285.24 =========