builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 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.764275) ========= 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.764669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.764937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.699537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.699796) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:18:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-06-28 01:18:39 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124695 ========= master_lag: 0.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.345314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.349646) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019387 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.582083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.582421) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:18:39,971 truncating revision to first 12 chars 2016-06-28 01:18:39,971 Setting DEBUG logging. 2016-06-28 01:18:39,971 attempt 1/10 2016-06-28 01:18:39,971 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,274 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634148 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.275066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.275366) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.279950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.280315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.380134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 01:18:40.380476) ========= /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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 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-036', 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": 376, 01:18:41 INFO - "slavename": "talos-linux64-ix-036", 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:42 INFO - Downloaded 1361 bytes. 01:18:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:42 INFO - Using the following test package requirements: 01:18:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:18:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:18:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'jsshell-linux-x86_64.zip'], 01:18:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:18:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:18:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:18:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:18:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:18:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:18:42 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:42 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:42 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:42 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:42 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:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:18:43 INFO - Downloaded 24525033 bytes. 01:18:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:18:44 INFO - Return code: 0 01:18:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:18:44 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:44 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:44 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:44 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:44 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:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:18:48 INFO - Downloaded 24525033 bytes. 01:18:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:18:49 INFO - Return code: 0 01:18:49 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:49 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:18:50 INFO - Downloaded 10833369 bytes. 01:18:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:18:50 INFO - Return code: 0 01:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:50 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:50 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:18:54 INFO - Downloaded 63614591 bytes. 01:18:54 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:18:54 INFO - mkdir: /builds/slave/test/properties 01:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:18:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:18:54 INFO - Contents: 01:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:54 INFO - Running post-action listener: _resource_record_post_action 01:18:54 INFO - Running post-action listener: set_extra_try_arguments 01:18:54 INFO - ##### 01:18:54 INFO - ##### Finished download-and-extract step (success) 01:18:54 INFO - ##### 01:18:54 INFO - ##### 01:18:54 INFO - ##### Running populate-webroot step. 01:18:54 INFO - ##### 01:18:54 INFO - Running pre-action listener: _resource_record_pre_action 01:18:54 INFO - Running main action method: populate_webroot 01:18:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:18:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:18:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:18:54 INFO - '--tppagecycles', 01:18:54 INFO - '7'], 01:18:54 INFO - 'tests': ['tsvgm']}}, 01:18:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:18:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:18:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:18:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:18:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['damp', 'tps']}, 01:18:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'tests': ['damp', 'tps']}, 01:18:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['dromaeo_dom']}, 01:18:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:18:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['a11yr', 01:18:54 INFO - 'ts_paint', 01:18:54 INFO - 'tpaint', 01:18:54 INFO - 'sessionrestore', 01:18:54 INFO - 'sessionrestore_no_auto_restore', 01:18:54 INFO - 'tabpaint']}, 01:18:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['tsvgx', 01:18:54 INFO - 'tsvgr_opacity', 01:18:54 INFO - 'tart', 01:18:54 INFO - 'tscrollx', 01:18:54 INFO - 'cart']}, 01:18:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:18:54 INFO - 'tsvgr_opacity', 01:18:54 INFO - 'tart', 01:18:54 INFO - 'tscrollx', 01:18:54 INFO - 'cart']}, 01:18:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'talos_options': ['--disable-e10s'], 01:18:54 INFO - 'tests': ['tp5o']}, 01:18:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'tests': ['tp5o']}, 01:18:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'talos_options': ['--disable-e10s', 01:18:54 INFO - '--xperf_path', 01:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:54 INFO - 'tests': ['tp5n']}, 01:18:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:54 INFO - 'talos_options': ['--xperf_path', 01:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:54 INFO - 'tests': ['tp5n']}}, 01:18:54 INFO - 'talos.zip': {'path': '', 01:18:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:18:54 INFO - Running post-action listener: _resource_record_post_action 01:18:54 INFO - ##### 01:18:54 INFO - ##### Finished populate-webroot step (success) 01:18:54 INFO - ##### 01:18:54 INFO - ##### 01:18:54 INFO - ##### Running create-virtualenv step. 01:18:54 INFO - ##### 01:18:54 INFO - Running pre-action listener: _resource_record_pre_action 01:18:54 INFO - Running main action method: create_virtualenv 01:18:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:18:54 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:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:18:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:18:54 INFO - Using real prefix '/usr' 01:18:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:18:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:18:57 INFO - Installing pip.................done. 01:18:57 INFO - Return code: 0 01:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:57 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:18:57 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:18:57 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:18:57 INFO - Using env: {'DISPLAY': ':0', 01:18:57 INFO - 'HOME': '/home/cltbld', 01:18:57 INFO - 'LANG': 'en_US.UTF-8', 01:18:57 INFO - 'LANGUAGE': 'en_US:en', 01:18:57 INFO - 'LOGNAME': 'cltbld', 01:18:57 INFO - 'MAIL': '/var/mail/cltbld', 01:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:57 INFO - 'MOZ_NO_REMOTE': '1', 01:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:57 INFO - 'NO_EM_RESTART': '1', 01:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:57 INFO - 'PWD': '/builds/slave/test', 01:18:57 INFO - 'SHELL': '/bin/bash', 01:18:57 INFO - 'SHLVL': '1', 01:18:57 INFO - 'TERM': 'linux', 01:18:57 INFO - 'TMOUT': '86400', 01:18:57 INFO - 'USER': 'cltbld', 01:18:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:57 INFO - '_': '/tools/buildbot/bin/python'} 01:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:57 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:18:57 INFO - Cleaning up... 01:18:57 INFO - Return code: 0 01:18:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:57 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:18:57 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:18:57 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:18:57 INFO - Using env: {'DISPLAY': ':0', 01:18:57 INFO - 'HOME': '/home/cltbld', 01:18:57 INFO - 'LANG': 'en_US.UTF-8', 01:18:57 INFO - 'LANGUAGE': 'en_US:en', 01:18:57 INFO - 'LOGNAME': 'cltbld', 01:18:57 INFO - 'MAIL': '/var/mail/cltbld', 01:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:57 INFO - 'MOZ_NO_REMOTE': '1', 01:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:57 INFO - 'NO_EM_RESTART': '1', 01:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:57 INFO - 'PWD': '/builds/slave/test', 01:18:57 INFO - 'SHELL': '/bin/bash', 01:18:57 INFO - 'SHLVL': '1', 01:18:57 INFO - 'TERM': 'linux', 01:18:57 INFO - 'TMOUT': '86400', 01:18:57 INFO - 'USER': 'cltbld', 01:18:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:57 INFO - '_': '/tools/buildbot/bin/python'} 01:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:57 INFO - Downloading/unpacking psutil>=3.1.1 01:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:18:59 INFO - Installing collected packages: psutil 01:18:59 INFO - Running setup.py install for psutil 01:18:59 INFO - building 'psutil._psutil_linux' extension 01:18:59 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:00 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:00 INFO - building 'psutil._psutil_posix' extension 01:19:00 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:00 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:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:00 INFO - Successfully installed psutil 01:19:00 INFO - Cleaning up... 01:19:00 INFO - Return code: 0 01:19:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:00 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 01:19:00 INFO - 'HOME': '/home/cltbld', 01:19:00 INFO - 'LANG': 'en_US.UTF-8', 01:19:00 INFO - 'LANGUAGE': 'en_US:en', 01:19:00 INFO - 'LOGNAME': 'cltbld', 01:19:00 INFO - 'MAIL': '/var/mail/cltbld', 01:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:00 INFO - 'MOZ_NO_REMOTE': '1', 01:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:00 INFO - 'NO_EM_RESTART': '1', 01:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:00 INFO - 'PWD': '/builds/slave/test', 01:19:00 INFO - 'SHELL': '/bin/bash', 01:19:00 INFO - 'SHLVL': '1', 01:19:00 INFO - 'TERM': 'linux', 01:19:00 INFO - 'TMOUT': '86400', 01:19:00 INFO - 'USER': 'cltbld', 01:19:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:00 INFO - '_': '/tools/buildbot/bin/python'} 01:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19: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:19: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:19: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:19: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:19: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:19: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:19:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:02 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:02 INFO - Installing collected packages: mozsystemmonitor 01:19:02 INFO - Running setup.py install for mozsystemmonitor 01:19:02 INFO - Successfully installed mozsystemmonitor 01:19:02 INFO - Cleaning up... 01:19:02 INFO - Return code: 0 01:19:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 01:19:02 INFO - 'HOME': '/home/cltbld', 01:19:02 INFO - 'LANG': 'en_US.UTF-8', 01:19:02 INFO - 'LANGUAGE': 'en_US:en', 01:19:02 INFO - 'LOGNAME': 'cltbld', 01:19:02 INFO - 'MAIL': '/var/mail/cltbld', 01:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:02 INFO - 'MOZ_NO_REMOTE': '1', 01:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:02 INFO - 'NO_EM_RESTART': '1', 01:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:02 INFO - 'PWD': '/builds/slave/test', 01:19:02 INFO - 'SHELL': '/bin/bash', 01:19:02 INFO - 'SHLVL': '1', 01:19:02 INFO - 'TERM': 'linux', 01:19:02 INFO - 'TMOUT': '86400', 01:19:02 INFO - 'USER': 'cltbld', 01:19:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:02 INFO - '_': '/tools/buildbot/bin/python'} 01:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:02 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:02 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:02 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:02 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:02 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:02 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:02 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:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:04 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:04 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:04 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:04 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:04 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:04 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:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:05 INFO - warning: no files found matching '*.txt' 01:19:05 INFO - no previously-included directories found matching 'build' 01:19:05 INFO - no previously-included directories found matching 'dist' 01:19:05 INFO - no previously-included directories found matching '.git*' 01:19:05 INFO - Installing collected packages: jsonschema, functools32 01:19:05 INFO - Running setup.py install for functools32 01:19:05 INFO - warning: no files found matching '*.txt' 01:19:05 INFO - no previously-included directories found matching 'build' 01:19:05 INFO - no previously-included directories found matching 'dist' 01:19:05 INFO - no previously-included directories found matching '.git*' 01:19:05 INFO - Successfully installed jsonschema functools32 01:19:05 INFO - Cleaning up... 01:19:05 INFO - Return code: 0 01:19:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:05 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 01:19:05 INFO - 'HOME': '/home/cltbld', 01:19:05 INFO - 'LANG': 'en_US.UTF-8', 01:19:05 INFO - 'LANGUAGE': 'en_US:en', 01:19:05 INFO - 'LOGNAME': 'cltbld', 01:19:05 INFO - 'MAIL': '/var/mail/cltbld', 01:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:05 INFO - 'MOZ_NO_REMOTE': '1', 01:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:05 INFO - 'NO_EM_RESTART': '1', 01:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:05 INFO - 'PWD': '/builds/slave/test', 01:19:05 INFO - 'SHELL': '/bin/bash', 01:19:05 INFO - 'SHLVL': '1', 01:19:05 INFO - 'TERM': 'linux', 01:19:05 INFO - 'TMOUT': '86400', 01:19:05 INFO - 'USER': 'cltbld', 01:19:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:05 INFO - '_': '/tools/buildbot/bin/python'} 01:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:05 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:07 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:07 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:07 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:07 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:07 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:07 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:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:07 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:07 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:07 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:07 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:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:08 INFO - Downloading docopt-0.6.1.tar.gz 01:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:08 INFO - Running setup.py install for blobuploader 01:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:08 INFO - Running setup.py install for requests 01:19:08 INFO - Running setup.py install for docopt 01:19:08 INFO - Successfully installed blobuploader requests docopt 01:19:08 INFO - Cleaning up... 01:19:08 INFO - Return code: 0 01:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 01:19:08 INFO - 'HOME': '/home/cltbld', 01:19:08 INFO - 'LANG': 'en_US.UTF-8', 01:19:08 INFO - 'LANGUAGE': 'en_US:en', 01:19:08 INFO - 'LOGNAME': 'cltbld', 01:19:08 INFO - 'MAIL': '/var/mail/cltbld', 01:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:08 INFO - 'MOZ_NO_REMOTE': '1', 01:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:08 INFO - 'NO_EM_RESTART': '1', 01:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:08 INFO - 'PWD': '/builds/slave/test', 01:19:08 INFO - 'SHELL': '/bin/bash', 01:19:08 INFO - 'SHLVL': '1', 01:19:08 INFO - 'TERM': 'linux', 01:19:08 INFO - 'TMOUT': '86400', 01:19:08 INFO - 'USER': 'cltbld', 01:19:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:08 INFO - '_': '/tools/buildbot/bin/python'} 01:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:09 INFO - Running setup.py (path:/tmp/pip-Au6t61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:09 INFO - Running setup.py (path:/tmp/pip-Cc0KaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:09 INFO - Running setup.py (path:/tmp/pip-pZ7tlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:09 INFO - Running setup.py (path:/tmp/pip-Yb1i1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:09 INFO - Running setup.py (path:/tmp/pip-9jwo1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:09 INFO - Running setup.py (path:/tmp/pip-Ic7xcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:09 INFO - Running setup.py (path:/tmp/pip-rIsP_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:09 INFO - Running setup.py (path:/tmp/pip-9KHBCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:09 INFO - Running setup.py (path:/tmp/pip-L1J9xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:09 INFO - Running setup.py (path:/tmp/pip-KgNHMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:09 INFO - Running setup.py (path:/tmp/pip-ZYOfkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:09 INFO - Running setup.py (path:/tmp/pip-vnwsDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:09 INFO - Running setup.py (path:/tmp/pip-TRjtk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:09 INFO - Running setup.py (path:/tmp/pip-Jun2b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:10 INFO - Running setup.py (path:/tmp/pip-HjMRrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:10 INFO - Running setup.py (path:/tmp/pip-4Y6wVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:10 INFO - Running setup.py (path:/tmp/pip-25HrAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:10 INFO - Running setup.py install for manifestparser 01:19:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:10 INFO - Running setup.py install for mozcrash 01:19:10 INFO - Running setup.py install for mozdebug 01:19:10 INFO - Running setup.py install for mozdevice 01:19:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:10 INFO - Running setup.py install for mozfile 01:19:10 INFO - Running setup.py install for mozhttpd 01:19:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:10 INFO - Running setup.py install for mozinfo 01:19:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:10 INFO - Running setup.py install for mozInstall 01:19:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Running setup.py install for mozleak 01:19:11 INFO - Running setup.py install for mozlog 01:19:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Running setup.py install for moznetwork 01:19:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Running setup.py install for mozprocess 01:19:11 INFO - Running setup.py install for mozprofile 01:19:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Running setup.py install for mozrunner 01:19:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:11 INFO - Running setup.py install for mozscreenshot 01:19:11 INFO - Running setup.py install for moztest 01:19:11 INFO - Running setup.py install for mozversion 01:19:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:12 INFO - Cleaning up... 01:19:12 INFO - Return code: 0 01:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:12 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 01:19:12 INFO - 'HOME': '/home/cltbld', 01:19:12 INFO - 'LANG': 'en_US.UTF-8', 01:19:12 INFO - 'LANGUAGE': 'en_US:en', 01:19:12 INFO - 'LOGNAME': 'cltbld', 01:19:12 INFO - 'MAIL': '/var/mail/cltbld', 01:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:12 INFO - 'MOZ_NO_REMOTE': '1', 01:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:12 INFO - 'NO_EM_RESTART': '1', 01:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:12 INFO - 'PWD': '/builds/slave/test', 01:19:12 INFO - 'SHELL': '/bin/bash', 01:19:12 INFO - 'SHLVL': '1', 01:19:12 INFO - 'TERM': 'linux', 01:19:12 INFO - 'TMOUT': '86400', 01:19:12 INFO - 'USER': 'cltbld', 01:19:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:12 INFO - '_': '/tools/buildbot/bin/python'} 01:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:12 INFO - Running setup.py (path:/tmp/pip-ye_m96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:12 INFO - Running setup.py (path:/tmp/pip-DFFwy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:12 INFO - Running setup.py (path:/tmp/pip-OrRwAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:12 INFO - Running setup.py (path:/tmp/pip-9lzRoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:12 INFO - Running setup.py (path:/tmp/pip-SVXvYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:12 INFO - Running setup.py (path:/tmp/pip-ZIE_M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:12 INFO - Running setup.py (path:/tmp/pip-U3cJBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:12 INFO - Running setup.py (path:/tmp/pip-63H0qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:12 INFO - Running setup.py (path:/tmp/pip-8Q48Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:12 INFO - Running setup.py (path:/tmp/pip-JRdnjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:12 INFO - Running setup.py (path:/tmp/pip-Dnv0Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:13 INFO - Running setup.py (path:/tmp/pip-zkV0mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:13 INFO - Running setup.py (path:/tmp/pip-vj0PjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:13 INFO - Running setup.py (path:/tmp/pip-mGq00O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:13 INFO - Running setup.py (path:/tmp/pip-C1GGLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:13 INFO - Running setup.py (path:/tmp/pip-PsFpGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:13 INFO - Running setup.py (path:/tmp/pip-1V5qwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:15 INFO - Downloading blessings-1.6.tar.gz 01:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:15 INFO - Installing collected packages: blessings 01:19:15 INFO - Running setup.py install for blessings 01:19:15 INFO - Successfully installed blessings 01:19:15 INFO - Cleaning up... 01:19:15 INFO - Return code: 0 01:19:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:15 INFO - Reading from file tmpfile_stdout 01:19:15 INFO - Current package versions: 01:19:15 INFO - argparse == 1.2.1 01:19:15 INFO - blessings == 1.6 01:19:15 INFO - blobuploader == 1.2.4 01:19:15 INFO - docopt == 0.6.1 01:19:15 INFO - functools32 == 3.2.3-2 01:19:15 INFO - jsonschema == 2.5.1 01:19:15 INFO - manifestparser == 1.1 01:19:15 INFO - mozInstall == 1.12 01:19:15 INFO - mozcrash == 0.17 01:19:15 INFO - mozdebug == 0.1 01:19:15 INFO - mozdevice == 0.48 01:19:15 INFO - mozfile == 1.2 01:19:15 INFO - mozhttpd == 0.7 01:19:15 INFO - mozinfo == 0.9 01:19:15 INFO - mozleak == 0.1 01:19:15 INFO - mozlog == 3.2 01:19:15 INFO - moznetwork == 0.27 01:19:15 INFO - mozprocess == 0.22 01:19:15 INFO - mozprofile == 0.28 01:19:15 INFO - mozrunner == 6.11 01:19:15 INFO - mozscreenshot == 0.1 01:19:15 INFO - mozsystemmonitor == 0.3 01:19:15 INFO - moztest == 0.7 01:19:15 INFO - mozversion == 1.4 01:19:15 INFO - psutil == 3.1.1 01:19:15 INFO - requests == 1.2.3 01:19:15 INFO - wsgiref == 0.1.2 01:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:15 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 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 01:19:15 INFO - 'HOME': '/home/cltbld', 01:19:15 INFO - 'LANG': 'en_US.UTF-8', 01:19:15 INFO - 'LANGUAGE': 'en_US:en', 01:19:15 INFO - 'LOGNAME': 'cltbld', 01:19:15 INFO - 'MAIL': '/var/mail/cltbld', 01:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:15 INFO - 'MOZ_NO_REMOTE': '1', 01:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:15 INFO - 'NO_EM_RESTART': '1', 01:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:15 INFO - 'PWD': '/builds/slave/test', 01:19:15 INFO - 'SHELL': '/bin/bash', 01:19:15 INFO - 'SHLVL': '1', 01:19:15 INFO - 'TERM': 'linux', 01:19:15 INFO - 'TMOUT': '86400', 01:19:15 INFO - 'USER': 'cltbld', 01:19:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:15 INFO - '_': '/tools/buildbot/bin/python'} 01:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Cleaning up... 01:19:16 INFO - Return code: 0 01:19:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:19:16 INFO - Using env: {'DISPLAY': ':0', 01:19:16 INFO - 'HOME': '/home/cltbld', 01:19:16 INFO - 'LANG': 'en_US.UTF-8', 01:19:16 INFO - 'LANGUAGE': 'en_US:en', 01:19:16 INFO - 'LOGNAME': 'cltbld', 01:19:16 INFO - 'MAIL': '/var/mail/cltbld', 01:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:16 INFO - 'MOZ_NO_REMOTE': '1', 01:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:16 INFO - 'NO_EM_RESTART': '1', 01:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:16 INFO - 'PWD': '/builds/slave/test', 01:19:16 INFO - 'SHELL': '/bin/bash', 01:19:16 INFO - 'SHLVL': '1', 01:19:16 INFO - 'TERM': 'linux', 01:19:16 INFO - 'TMOUT': '86400', 01:19:16 INFO - 'USER': 'cltbld', 01:19:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:16 INFO - '_': '/tools/buildbot/bin/python'} 01:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:16 INFO - Cleaning up... 01:19:16 INFO - Return code: 0 01:19:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f55a5875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, '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': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:19:16 INFO - Using env: {'DISPLAY': ':0', 01:19:16 INFO - 'HOME': '/home/cltbld', 01:19:16 INFO - 'LANG': 'en_US.UTF-8', 01:19:16 INFO - 'LANGUAGE': 'en_US:en', 01:19:16 INFO - 'LOGNAME': 'cltbld', 01:19:16 INFO - 'MAIL': '/var/mail/cltbld', 01:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:16 INFO - 'MOZ_NO_REMOTE': '1', 01:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:16 INFO - 'NO_EM_RESTART': '1', 01:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:16 INFO - 'PWD': '/builds/slave/test', 01:19:16 INFO - 'SHELL': '/bin/bash', 01:19:16 INFO - 'SHLVL': '1', 01:19:16 INFO - 'TERM': 'linux', 01:19:16 INFO - 'TMOUT': '86400', 01:19:16 INFO - 'USER': 'cltbld', 01:19:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:16 INFO - '_': '/tools/buildbot/bin/python'} 01:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:16 INFO - Downloading/unpacking flake8 01:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:19:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:19:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:19:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:19 INFO - no previously-included directories found matching 'docs/_build' 01:19:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:19:19 INFO - Running setup.py install for pep8 01:19:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:19 INFO - no previously-included directories found matching 'docs/_build' 01:19:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:19:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:19:19 INFO - Cleaning up... 01:19:19 INFO - Return code: 0 01:19:19 INFO - Running post-action listener: _resource_record_post_action 01:19:19 INFO - Running post-action listener: _start_resource_monitoring 01:19:19 INFO - Starting resource monitoring. 01:19:19 INFO - ##### 01:19:19 INFO - ##### Finished create-virtualenv step (success) 01:19:19 INFO - ##### 01:19:19 INFO - ##### 01:19:19 INFO - ##### Running install step. 01:19:19 INFO - ##### 01:19:19 INFO - Running pre-action listener: _resource_record_pre_action 01:19:19 INFO - Running main action method: install 01:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:19 INFO - Reading from file tmpfile_stdout 01:19:19 INFO - Detecting whether we're running mozinstall >=1.0... 01:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:19:19 INFO - Reading from file tmpfile_stdout 01:19:19 INFO - Output received: 01:19:19 INFO - Usage: mozinstall [options] installer 01:19:19 INFO - Options: 01:19:19 INFO - -h, --help show this help message and exit 01:19:19 INFO - -d DEST, --destination=DEST 01:19:19 INFO - Directory to install application into. [default: 01:19:19 INFO - "/builds/slave/test"] 01:19:19 INFO - --app=APP Application being installed. [default: firefox] 01:19:19 INFO - mkdir: /builds/slave/test/build/application 01:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:19:35 INFO - Reading from file tmpfile_stdout 01:19:35 INFO - Output received: 01:19:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:19:35 INFO - Running post-action listener: _resource_record_post_action 01:19:35 INFO - ##### 01:19:35 INFO - ##### Finished install step (success) 01:19:35 INFO - ##### 01:19:35 INFO - ##### 01:19:35 INFO - ##### Running run-tests 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: run_tests 01:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:35 INFO - Python 2.7.3 01:19:35 INFO - Return code: 0 01:19:35 INFO - grabbing minidump binary from tooltool 01:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:35 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 0x1e581c0>, '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 0x1e590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e59550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:19:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:19:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:19:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:19:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:35 INFO - Return code: 0 01:19:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:19:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:19:36 INFO - Return code: 0 01:19:36 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-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:19:36 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-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:19:36 INFO - Using env: {'DISPLAY': ':0', 01:19:36 INFO - 'HOME': '/home/cltbld', 01:19:36 INFO - 'LANG': 'en_US.UTF-8', 01:19:36 INFO - 'LANGUAGE': 'en_US:en', 01:19:36 INFO - 'LOGNAME': 'cltbld', 01:19:36 INFO - 'MAIL': '/var/mail/cltbld', 01:19:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:36 INFO - 'MOZ_NO_REMOTE': '1', 01:19:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:36 INFO - 'NO_EM_RESTART': '1', 01:19:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:36 INFO - 'PWD': '/builds/slave/test', 01:19:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:36 INFO - 'SHELL': '/bin/bash', 01:19:36 INFO - 'SHLVL': '1', 01:19:36 INFO - 'TERM': 'linux', 01:19:36 INFO - 'TMOUT': '86400', 01:19:36 INFO - 'USER': 'cltbld', 01:19:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244', 01:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:36 INFO - '_': '/tools/buildbot/bin/python'} 01:19:36 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-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:19:36 INFO - mozversion application_buildid: 20160627130921 01:19:36 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:19:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:36 INFO - mozversion application_name: Firefox 01:19:36 INFO - mozversion application_remotingname: firefox-dev 01:19:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:36 INFO - mozversion application_vendor: Mozilla 01:19:36 INFO - mozversion application_version: 49.0a2 01:19:36 INFO - mozversion platform_buildid: 20160627130921 01:19:36 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:36 INFO - mozversion platform_version: 49.0a2 01:19:36 INFO - using testdate: 1467101976 01:19:36 INFO - actual date: 1467101976 01:19:36 INFO - starting webserver on 'localhost:45297' 01:19:36 INFO - SUITE-START | Running 2 tests 01:19:36 INFO - TEST-START | dromaeo_css 01:19:36 INFO - operating with platform_type : linux_ 01:19:36 INFO - Initialising browser for dromaeo_css test... 01:19:36 INFO - TEST-INFO | started process 9509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYt9xN_/profile http://localhost:45297/getInfo.html) 01:19:41 INFO - PROCESS | 9509 | __metrics Screen width/height:1600/1200 01:19:41 INFO - PROCESS | 9509 | colorDepth:24 01:19:41 INFO - PROCESS | 9509 | Browser inner width/height: 1024/697 01:19:41 INFO - PROCESS | 9509 | __metrics 01:19:42 ERROR - PROCESS | 9509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:19:43 INFO - TEST-INFO | 9509: exit 0 01:19:43 INFO - Browser initialized. 01:19:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:19:43 INFO - TEST-INFO | started process 9633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYt9xN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:54 INFO - PROCESS | 9633 | RSS: Main: 156168192 01:19:54 INFO - PROCESS | 9633 | 01:20:44 INFO - PROCESS | 9633 | 1467102044508 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:22:52 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45297/tests/dromaeo/cssquery-ext.html) 01:22:53 INFO - PROCESS | 9633 | RSS: Main: 159866880 01:22:53 INFO - PROCESS | 9633 | 01:25:55 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-ext.html (next: http://localhost:45297/tests/dromaeo/cssquery-jquery.html) 01:25:56 INFO - PROCESS | 9633 | RSS: Main: 157335552 01:25:56 INFO - PROCESS | 9633 | 01:28:58 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45297/tests/dromaeo/cssquery-mootools.html) 01:28:58 INFO - PROCESS | 9633 | RSS: Main: 156917760 01:28:58 INFO - PROCESS | 9633 | 01:32:00 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45297/tests/dromaeo/cssquery-prototype.html) 01:32:01 INFO - PROCESS | 9633 | RSS: Main: 156340224 01:32:01 INFO - PROCESS | 9633 | 01:35:03 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45297/tests/dromaeo/cssquery-yui.html) 01:35:04 INFO - PROCESS | 9633 | RSS: Main: 158781440 01:35:04 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | Cycle 1(1): loaded http://localhost:45297/tests/dromaeo/cssquery-yui.html (next: http://localhost:45297/tests/dromaeo/cssquery-dojo.html) 01:38:06 INFO - PROCESS | 9633 | RSS: Main: 158863360 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | __start_tp_report 01:38:06 INFO - PROCESS | 9633 | _x_x_mozilla_page_load 01:38:06 INFO - PROCESS | 9633 | _x_x_mozilla_page_load_details 01:38:06 INFO - PROCESS | 9633 | |i|pagename|runs| 01:38:06 INFO - PROCESS | 9633 | |0;dojo.html;3451.8791842285523;3462.2383075723333;3480.356134115188;3481.912952176197;3484.738644601654;5841.591088623798;5848.356680765112;5884.794032208873;5902.468777809991;5960.582759206857;5845.941540584593;5865.472107510323;5919.1713160157615;5924.911126333109;5940.405959404057;5284.313039304895;5328.92006619901;5399.271098401724;5406.59450541209;5429.701366424845;5275.287836142129;5275.472452754713;5316.096263635172;5443.863903402407;5446.754896029688;5320.680759154463;5341.06531357013;5350.35795704516;5354.9196762048605;5383.81156659517;5399.325084364474;5401.054815407328;5406.459354064562;5421.972890135544;5436.91844622331;5056.924146137811;5232.895342093175;5251.711155886424;5276.918231762479;5302.1781623848365;5745.454181852718;5750.626209296424;5786.508146807484;5792.710364481801;5801.50687191585;6359.713812878385;6368.203974503187;6382.712777925005;6395.616263024233;6409.134766806468;6199.783007594758;6260.373962603749;6302;6302.653354065525;6441.935580644227;5914.201582786269;5914.615549989237;5916.230889984317;5916.7337469813965;5932.703364831785;6451.451701564121;6471.546991710629;6474.5791523550815;6475.4819614430735;6488.545801793829;5981.820545383645;6134.04922237054;6158.692065396802;6158.815235542941;6243.125962365272;6318.241810982711;6343.238811342669;6376.553641245068;6381.202349706286;6384.07430922523;6138.048602466625;6330.493560515148;6332.8416789579705;6338.619682819046;6349.587276826992;6216.502679785606;6236;6256.468200203034;6329.367063293726;6344.175257216532;4775.092732380836;4777.593904518086;4793.400824896888;4797.808087676523;4819.132556139858;4227.915441691211;4260.893477663083;4284.335927931175;4287.206866729665;4292.184484947912;5861.912071318934;5931.139984702194;5955.225820643375;6081.75672973085;6088.543359248074;6306.558540902184;6312.242530896322;6330.8100756977365;6340.1440805490665;6341.365863413714;5859.589828711949;5993.310769261503;6007.969960150172;6019.578629495893;6048.0625503047095;5431.972840135774;5433.972830135824;5443.673379597237;5446.373667028342;5463.9180412293845;6573.112629795012;6605.339466053452;6610;6618.669066546653;6636.966815165893;6143.938560614337;6206.131141640084;6217.844553886189;6273.3099359071375;6404.423601875854;6528.37980391862;6544.44372228366;6556.80329590094;6581.3418658133805;6585.934140658532;6246.906296405648;6249.25008998923;6250.843728906813;6260.561760676709;6267;6145.740123274629;6277.089821975879;6283.3402492737605;6344.175257216532;6440.484761218998;6194.5354098443695;6199.256089269316;6205.875882482415;6255.40573645503;6278.246610406781;6022.307434645072;6188.257409110755;6246.281677606951;6253.530985176221;6253.593516421418;6051.394860513913;6071.817845464643;6077.817665470043;6138.846528836636;6153.446189842935;6228.4705800007505;6233.252009758858;6250.406211409909;6253.343398943045;6274.341194174728;5886.499647530008;6005.7297421617;6059.939510585718;6085.3306136325855;6118.755249789959 01:38:06 INFO - PROCESS | 9633 | |1;ext.html;577.3850848845979;620.0544170140536;637.9601249962558;648.2286079565317;680.3808534233848;43394;47573.762131189294;47581.286280705775;47747.28379074308;47859.28211076832;48296;48406.75796621021;48711;48855.75572122143;48873.26690099651;9121;9152.771180720469;9204.815903681922;9215.308851836106;9245;9103.226225770817;9125.817483650322;9135.26917846574;9199.264058875307;9225.769355766093;9088.409253398508;9196.218321442686;9209;9256.72229833106;9258.6296548138;9202.125798049208;9234.722958311228;9234.815303693922;9246.722598321994;9262.212711919496;8966.730998070068;9034.954825225897;9043.728688139367;9055.547222638908;9062.546872656341;45666.08667826658;45808.54191458076;45855.54144458546;45900.311495327594;46106;3763.9623603764157;3975.4434379186937;3980.024893900984;4069.9796501017304;4527.071950250223;34470;35106;35426.46860297098;35603;35619.10952226189;4700.177468942921;4797.544233297831;4800.759962001921;4809.062232864593;4869.342638743759;400185;400448;400536;401295;401342;68553.65723171353;69009;69126.65436672785;69145.3085469149;69292;40017;41116.794416027726;41245.58754412478;42880.571194288284;72571;19764.60470790576;19917.10373033217;19960.500987475138;20090.799092009183;20093.39719808408;15442.691146177238;15590.610234743996;15700.136492493022;15701;15724.371025158865;21813.78186218149;21896.343109706733;21998;22026.11895524161;22136.88931555332;7946.602669866484;7968.521888686697;7975.8404831903035;8023.277904988579;8024.598770061473;1023.4626820918928;1070.6573896353248;1083.9349639021684;1084.8860869608577;1102.2835157147758;34690.82654586761;35496;35971.64028359735;38595.22809543793;38666.42000369997;1153.5962413155496;1172.888575585318;1198.4846515998204;1224.7550489902055;1258.3959699344182;17972.640547188985;18344.174512146987;18379.356722514647;18517.259309627734;18525.166367513495;973352;986352;988651;995141;1052821;63350.683246583474;63372.68313658402;63620.36379636237;63809.680951595874;64528.35471645317;1507.7512210485147;1514.674345015827;1522.5584580471539;1527.4348491058158;1537.569480545449;32690.34619307553;33838.66161338355;33848;34010.489842652874;34981;56043.15935261056;56671;56672.43327566671;56789.71605141948;64380.35619643744;425947;557121;562998;564889;571550;49176.75411622919;49230.26154607612;49729.50270497249;50323.24515132349;51066.23400648919;55998.16002760043;56407.43592564186;57217;57326.7133664329;58190;47500;47764.28353574769;47797;48102;48875.51124488709;46524.767376162905;47363.52636473729;47902.28146577734;48270.517294826604;48298.75850620725;47110.52889471062;47279.763601181774;48475.27287090626;48501.75749121373;48655.75672121617;39546;40061.79969100136;40516;40770.38844417396;40883;31019.534706979866;31148.68851311458;31388.68611313949;31809.840950795096;31845 01:38:06 INFO - PROCESS | 9633 | |2;jquery.html;430.42323286795687;433.59242312226513;433.670410488029;438.4705987152713;448.97306161630286;18422.53943651408;19886.801131988694;20258.594828103447;21389.786102138973;21438.24966126186;19570.412887613395;20074.89962550189;20772.06525706343;20857.26999555016;20900.16399344028;5849.912251316234;6018.247719035121;6043.093535969596;6046.455818976291;6060.181875446824;5667.829965101054;5820.796272130477;5863.79476718315;5883.970580147115;5900.350961394243;5759.539236861062;5796.391378905218;5811.506021988136;5823.737931793058;5837.5913686041995;5626.634268772516;5898.144769008512;5906.763729450817;5909.320428150775;5915.408459154093;5275.630705850592;5301.125314323132;5303.071962406563;5313.1764576490705;5318.44156363584;23723;23833.761662383327;23988.160414385588;24438.633420498707;24535.877320613283;2501.9874900625564;2543.173468622705;2576.896924123033;2822.417487998479;2832.3202431416516;15483.5354939352;15610.375584976588;15653.217339132998;15673.216339182994;16025.679486410323;2041.3467690339098;2051.8563700540967;2084.6351888419467;2133.7546182188935;2179.095675294751;83922;85579.5721021391;85584.14415855824;86269;86865.99999999937;11163.553457861595;11362.431878406047;11427.60003399877;11561.942190289163;11887.346195959306;16373;16384.508464746075;16518.174091295386;16528.586785330463;16571.42000029993;8821.117888211127;8863.601137948808;8920.330975176888;9075.863862042075;9456.05439456049;8496.70261540843;8605.612747426381;8624.69813556535;8663.653453861902;8834.602442890086;7086.326798954091;7150.10623672041;7197.4961752677855;7268.200497945222;7327.670254838545;2042.7344445222027;2069.9093915145813;2109.124713244017;2113.3765539165984;2143.20701340505;1049.7218237167158;1119.3172164979355;1160.3733983648735;1163.7963356412595;1172.1501911114544;19923.900380498006;19982;20154.496137596383;20602.27892023772;21095.578088438146;1086.9891301087046;1123.1688550472754;1166.690826930864;1168.2056201782868;1198.9880101198876;11674.88325116755;11756.823647645293;11884.643460696192;11923.761524769456;11959.701007474883;418060;422443;426302;523034;538236;109455;111964.44017779859;112552.43723781493;113391.43304283591;114252.42873785744;1092.229977865603;1093.4314156638504;1100.9119270458343;1127.774445110981;1131.8472006279046;18057.277708891495;18483.260669573065;18713.812861871753;18753.34363297278;18768.436946891616;44356.556434436534;45536;45633.31550026686;46379.30431043605;46535.76732116318;63445.682771585845;63792.68103659452;65145.02282465672;65361.67319163374;65435;8032.076311224284;8337.94889451086;8623.223909848144;9066.863997039918;9425.811483770423;13466.394012269275;13723.245221512912;14217.786733198804;14391;14453.132812031312;12516.749665006831;12522.311272880079;12601.18092323996;12668.556600518938;12857.164284321489;12352.320622365856;12537.247765134121;12817.23096614206;12837.165584236995;12844.614661560168;6306.400891915261;11207.49566269536;12211;12973.286469244282;13297.601071967856;8407.327413807003;8448.577571121543;8564.229219370287;8628.870566941627;8697.608607612547;12792.104552681223;12849.678758031125;12872.292023938773;12890.097693161764;12941.094123411647 01:38:06 INFO - PROCESS | 9633 | |3;mootools.html;1566.1284764706177;1606.7830842836217;1793.2647614478067;1893.8768980016307;1916.27181670965;8277.710280140196;8963.686270980517;9011.549422528871;9619.951900240498;9644.565994530245;9138.40600360976;9203.079692030811;9243.722688319345;9320.72037838866;9326.72019839406;2474.047491715689;2496.051500429834;2507.285423654259;2510.686164229471;2515.157422263544;2443.4380092578717;2482.5407299649623;2487.7387874273213;2491.9750802492017;2498.100683753847;2412.7828495435406;2436.537057958982;2458.9754102459015;2468.8395254308502;2469.7900678442265;2355.34050465869;2377.3105799318178;2395.5448464791634;2419.733829278778;2421.128393778238;2353.8940747666397;2355.316958082154;2374.7150341959077;2379.773921477457;2421.8546887186826;9364.672236471759;9382.437053776795;9386.249100071978;9460.053994600554;9476.715698529055;5775.971120144372;5900.203472531196;5905.114232865061;5905.557083218776;5905.881882362329;3515.54297941266;3653.6346365363515;3689.7232707546773;3696.9075773105887;3710.5547334320054;1135.3188087147646;1172.8006238939315;1173.4778023779422;1175;1202.5129822421934;12864.09951303409;12990.155639883471;13002.674933126653;13030.348482575833;13105.803412948813;4871.926921096187;4973.626977976666;5021.974890125526;5120.4111527174855;5136;11201;11324.490397932113;11388.65834024964;11392.715182120513;11405.201635885574;5726.828195154152;5856.8535786604825;5911.379305172981;5926.881462370815;5934.317553481319;4664.39362882823;5214.817481388133;5426.321709786277;5430.15832545956;5468.535174510132;4387.670924680661;4407.449068866392;4443;4455.710378825366;4505.391772110788;1402.880755135825;1427.6145440731152;1428.5928510374492;1445.8554144585667;1464.6704491489543;1017.0998666180484;1041.7864337810731;1044.6604853422668;1048.339546085961;1048.6224959014748;6040.486558642565;6119.816405507842;6219.440250377488;6336.8415789604705;6359.650219237894;502.8214983680814;506.2254750232077;510.6578592343139;511.8541215753492;514.0926265142027;4244.724092934011;4263.765492897858;4264.722793018444;4265.50946641134;4269.893252668709;11689.415529223676;11919.940400297943;11954.701132471759;12023.519059237708;12044.277343359427;11903.761924761457;12014.399280035963;12409.813852792035;12552.937235313764;12577.119601627799;8557.657693692183;8897.332700047393;8957.507337096393;9148.222401095849;9310.581023853943;6310.148130002574;6501.772437964649;6523.445507131947;6573.211214654272;6615.503837212132;11304.676391333287;11402.087832973508;11489.253198542068;11534.769304614028;11628.244164129304;11195.160362972647;11220;11357.886421135683;11407.885921140682;11530.82703759461;7897.368210543258;8478.872816907875;8643.91356086431;8734.388592798443;8935.508547029976;9713.611455541699;9760.267979901679;9803.068708472683;9852.261080418853;9910.504474776088;8320.334373250005;8385.077641459557;8403.579821008803;8425.87361189595;8467.703630372907;8358.080611132893;8379.329653627574;8404;8427.157284271523;8697.391182617155;7133.108361454818;7209.567425954459;7213.819654508679;7253.528520646141;7263.636818158965;5421.5391691706645;5452.427495112956;5476.0690682584855;5580.9441905580425;5621.269234999424;5295.470452954673;5430.185472179047;5440.401555828935;5440.782368705208;5458.372287187024 01:38:06 INFO - PROCESS | 9633 | |4;prototype.html;353.8973697627687;358.5625536845049;363.25895173845356;369.41078979028475;370.6515875077427;5624.650083979846;5653.816176029729;5805.98088993723;5824.359320474744;5851.824445266643;5695.629784064033;5699.629524080942;5699.914501282484;5708.4862362387485;5714.57140714446;4459.264221403465;4461.375407442961;4479.865604031885;4486.865394038184;4487.596116349528;4395.274779661368;4471.306947423138;4471.66462515311;4489.7449349221715;4495.303227999649;4413.6027757501815;4416.249237629595;4422.601965823092;4443.045060173529;4450.666200035011;4298.677599180042;4368.279233926399;4440.735225035255;4472;4486.708363956365;3866.5940076291868;3877.1470276539117;3882.0294926268434;3899.590542992973;3902.2195560887653;5511.696856672881;5524.972375138139;5554.527865131468;5562.3881373048935;5579.191017302509;4898.40384596161;5098.056859480971;5113.923291150636;5120;5126.410462796789;5998.40015998401;6001.909971350433;6003.699815009232;6008.459238668541;6038.96980515099;4311.935320970188;4312.3531470279395;4327.156204540116;4330.458692663417;4346;6182.557889633615;6289.779857705004;6350.809475715736;6351.333110023427;6382;4387.670924680661;4410.404595379647;4424.4956714717155;4428.31361139024;4445.777711114431;4454.532274111237;4456.197884380843;4481.731096134243;4508.120916421266;4509.864704058883;4989.351384320088;5116.846494605168;5121.308623335876;5150.995555866645;5167.121589329823;5865.765369385262;6030.3668114847305;6039.939600604026;6054.697265136726;6091.14723938649;1539.6074001129641;1547.8529539693711;1547.9303431345616;1553.5339398180502;1560;970.5292932927524;984.4241118945354;985.7683444390562;988.3921388346115;1006.6476733143342;5230.947690523122;5260.736963151904;5274.947250527523;5278.4721527846905;5279.392869819943;5507.201455788888;5533.501984821385;5609.523190528769;5611.494965453129;5635.675616230183;4967.907060446696;5127.564157046693;5228.424873263938;5252.343457067866;5268.525832675001;2888.768898488116;2968.6289213848268;2988.237999310162;3014.3971205758935;3014.6834582368974;5635.971820140873;5648.265725455664;5652.74562644682;5653.519450846724;5690.772369105272;5938;6413.6793160341795;6435.101645014732;6443.935560644427;6462.676866156768;6408.711607977559;6433.485321174388;6443.935560644427;6456.806295811133;6465;6097.390260973867;6264.812055638338;6302.968485157545;6339.5562310637815;6364.459020983269;6187.288461826767;6213.440790328892;6225.844353891189;6227.96886015567;6251.749930002931;6327.810165694852;6431.903521447276;6483.643399612878;6484.1246431731115;6493.772717954849;4348.2825333819565;4378.474583050054;4381.474223093249;4384.473863136444;4456.888577785581;6126.632402055891;6255.530835187288;6264.906026409516;6268.780592679234;6290.24517057956;6071.423214794588;6105.511559075352;6118.653896142841;6127.601705889103;6133.3866613338305;6070.785842831363;6100.511959043177;6101.7559297627595;6137.723802428812;6145.293291271382;5882.323532793613;6008.579399442172;6009.098635204754;6017.699115044318;6025.457708806229;6083.813656337149;6096.390360963868;6173.6913154343;6178.41305076017;6193.287771906288;5854.297484301911;5899.1730596792895;5949.691067965214;6002.609830361012;6011.939880601313 01:38:06 INFO - PROCESS | 9633 | |5;yui.html;787.3897729259819;806.9314108300794;807.2613558593887;861.67687117331;914.7530166854949;16713.665726685475;17538.21078051486;17549.73675394867;17611.64776704465;17651.02919339436;16162.515124546253;16249.431269905555;16328.591785205375;16334.918325408356;16335.754963675554;720.805382546712;843.2326582809644;862.3273846399818;870.4603146049427;872.3326655108815;858.6179150278128;861.3711990247092;861.4314552395421;865.446114486729;867.0072766682146;909.6225066597354;909.6816114359988;914.0037359278385;917.4724533393293;919.6413398774483;902.6028547439106;907.4555266839843;910.6266430763388;912.2747415804386;916.029009250197;670.2761018100489;670.8557660103102;671.8824205763972;673.737242475435;674.7739507265072;15789.28948197334;15866.761998570031;15919.522414327588;15942.840571594252;15982.680346393006;15727.019248514936;16243.51269461918;16324.510264692079;16502.2573984171;16619;13100.410481528354;13264.602061938158;13293.800592991112;13315.533956311483;13424;4003.619656132663;4035.0921042765435;4039.6970227233073;4117.608827161415;4124.030852749602;75012;75727.62136189338;79307.60346198232;84338;84497;10452.634157804441;10775;10881.782364352668;12399;12578.433970471351;20977.68533471999;21026.57946841085;21115.577688446145;21264.149434022467;21402.143914243567;8647.610857511427;8665.696700615448;8722.302215822845;8879.866801997976;8886.422382545114;4923.606111511071;4933.728644924564;5044.747762611854;5080.542751152414;5084.288199652052;3911.647951684362;4080.6735461163034;4095.140020595649;4121.9587804122175;4159.272127377697;665.7902760630386;671.4561205423622;671.7783131566571;681.2608319972786;690.2855544511507;754.3135746470685;829.5934991854069;841.6380956188898;850.3452341696859;874.9343799215085;10551.683449496528;10788.244822862482;10896.673099807018;10947.397893115955;11147.21969462146;630.9148264984168;685.3318014935398;751.4514404484756;803.1366281247682;809.680176330358;5029.321041659329;5070.670406423571;5119.718415487184;5213.530782229617;5217.165253559412;79138.45907880476;79903;81071;119140.40429797796;120099.39950300193;102598;103545.48227258815;103655;104105;107113;60487;61040;61311.693441533396;61807.38192618016;63171;9139.63441462334;9331.813363732552;9354.53227338644;9570.808583828424;9601.279904007368;53197.46802531925;53683.731581341846;53810;54960.72519637536;57250;73721.6313918427;80928;82070;82887;84965;12986;12994.895433887847;13003.154794938298;13159.47362105505;13167.868321317048;13243.07298489135;13340.799888001493;14161.858381416054;14243.287835608386;14784.556463306119;13379.331033448483;13466.93266533661;13849.376778045214;13898.444062237802;13947.30263486842;12963.481460741465;13033.348332583522;13148.60554183376;13238.735225295633;13267.336633168496;12928.547500837425;13763.587092387244;14193.29033548339;14195.787063194268;14972.775408369102;10704.678859634223;10893.78212435731;10982.890171098186;11072.058874995393;11098.223124381217;11302.43487825622;11726.41367931617;11774.882251177722;11791.29252244868;11911.404429778304 01:38:06 INFO - PROCESS | 9633 | __end_tp_report 01:38:06 INFO - PROCESS | 9633 | __start_cc_report 01:38:06 INFO - PROCESS | 9633 | _x_x_mozilla_cycle_collect,358 01:38:06 INFO - PROCESS | 9633 | __end_cc_report 01:38:06 INFO - PROCESS | 9633 | __startTimestamp1467103086761__endTimestamp 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | ------- Summary: start ------- 01:38:06 INFO - PROCESS | 9633 | Number of tests: 6 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#0] dojo.html Cycles:165 Average:5862.41 Median:6085.33 stddev:672.28 (11.0%) stddev-sans-first:647.20 01:38:06 INFO - PROCESS | 9633 | Values: 3451.9 3462.2 3480.4 3481.9 3484.7 5841.6 5848.4 5884.8 5902.5 5960.6 5845.9 5865.5 5919.2 5924.9 5940.4 5284.3 5328.9 5399.3 5406.6 5429.7 5275.3 5275.5 5316.1 5443.9 5446.8 5320.7 5341.1 5350.4 5354.9 5383.8 5399.3 5401.1 5406.5 5422.0 5436.9 5056.9 5232.9 5251.7 5276.9 5302.2 5745.5 5750.6 5786.5 5792.7 5801.5 6359.7 6368.2 6382.7 6395.6 6409.1 6199.8 6260.4 6302.0 6302.7 6441.9 5914.2 5914.6 5916.2 5916.7 5932.7 6451.5 6471.5 6474.6 6475.5 6488.5 5981.8 6134.0 6158.7 6158.8 6243.1 6318.2 6343.2 6376.6 6381.2 6384.1 6138.0 6330.5 6332.8 6338.6 6349.6 6216.5 6236.0 6256.5 6329.4 6344.2 4775.1 4777.6 4793.4 4797.8 4819.1 4227.9 4260.9 4284.3 4287.2 4292.2 5861.9 5931.1 5955.2 6081.8 6088.5 6306.6 6312.2 6330.8 6340.1 6341.4 5859.6 5993.3 6008.0 6019.6 6048.1 5432.0 5434.0 5443.7 5446.4 5463.9 6573.1 6605.3 6610.0 6618.7 6637.0 6143.9 6206.1 6217.8 6273.3 6404.4 6528.4 6544.4 6556.8 6581.3 6585.9 6246.9 6249.3 6250.8 6260.6 6267.0 6145.7 6277.1 6283.3 6344.2 6440.5 6194.5 6199.3 6205.9 6255.4 6278.2 6022.3 6188.3 6246.3 6253.5 6253.6 6051.4 6071.8 6077.8 6138.8 6153.4 6228.5 6233.3 6250.4 6253.3 6274.3 5886.5 6005.7 6059.9 6085.3 6118.8 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#1] ext.html Cycles:180 Average:80208.91 Median:47755.78 stddev:187715.01 (393.1%) stddev-sans-first:188146.39 01:38:06 INFO - PROCESS | 9633 | Values: 577.4 620.1 638.0 648.2 680.4 43394.0 47573.8 47581.3 47747.3 47859.3 48296.0 48406.8 48711.0 48855.8 48873.3 9121.0 9152.8 9204.8 9215.3 9245.0 9103.2 9125.8 9135.3 9199.3 9225.8 9088.4 9196.2 9209.0 9256.7 9258.6 9202.1 9234.7 9234.8 9246.7 9262.2 8966.7 9035.0 9043.7 9055.5 9062.5 45666.1 45808.5 45855.5 45900.3 46106.0 3764.0 3975.4 3980.0 4070.0 4527.1 34470.0 35106.0 35426.5 35603.0 35619.1 4700.2 4797.5 4800.8 4809.1 4869.3 400185.0 400448.0 400536.0 401295.0 401342.0 68553.7 69009.0 69126.7 69145.3 69292.0 40017.0 41116.8 41245.6 42880.6 72571.0 19764.6 19917.1 19960.5 20090.8 20093.4 15442.7 15590.6 15700.1 15701.0 15724.4 21813.8 21896.3 21998.0 22026.1 22136.9 7946.6 7968.5 7975.8 8023.3 8024.6 1023.5 1070.7 1083.9 1084.9 1102.3 34690.8 35496.0 35971.6 38595.2 38666.4 1153.6 1172.9 1198.5 1224.8 1258.4 17972.6 18344.2 18379.4 18517.3 18525.2 973352.0 986352.0 988651.0 995141.0 1052821.0 63350.7 63372.7 63620.4 63809.7 64528.4 1507.8 1514.7 1522.6 1527.4 1537.6 32690.3 33838.7 33848.0 34010.5 34981.0 56043.2 56671.0 56672.4 56789.7 64380.4 425947.0 557121.0 562998.0 564889.0 571550.0 49176.8 49230.3 49729.5 50323.2 51066.2 55998.2 56407.4 57217.0 57326.7 58190.0 47500.0 47764.3 47797.0 48102.0 48875.5 46524.8 47363.5 47902.3 48270.5 48298.8 47110.5 47279.8 48475.3 48501.8 48655.8 39546.0 40061.8 40516.0 40770.4 40883.0 31019.5 31148.7 31388.7 31809.8 31845.0 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#2] jquery.html Cycles:180 Average:29948.28 Median:11766.50 stddev:78016.15 (663.0%) stddev-sans-first:78203.52 01:38:06 INFO - PROCESS | 9633 | Values: 430.4 433.6 433.7 438.5 449.0 18422.5 19886.8 20258.6 21389.8 21438.2 19570.4 20074.9 20772.1 20857.3 20900.2 5849.9 6018.2 6043.1 6046.5 6060.2 5667.8 5820.8 5863.8 5884.0 5900.4 5759.5 5796.4 5811.5 5823.7 5837.6 5626.6 5898.1 5906.8 5909.3 5915.4 5275.6 5301.1 5303.1 5313.2 5318.4 23723.0 23833.8 23988.2 24438.6 24535.9 2502.0 2543.2 2576.9 2822.4 2832.3 15483.5 15610.4 15653.2 15673.2 16025.7 2041.3 2051.9 2084.6 2133.8 2179.1 83922.0 85579.6 85584.1 86269.0 86866.0 11163.6 11362.4 11427.6 11561.9 11887.3 16373.0 16384.5 16518.2 16528.6 16571.4 8821.1 8863.6 8920.3 9075.9 9456.1 8496.7 8605.6 8624.7 8663.7 8834.6 7086.3 7150.1 7197.5 7268.2 7327.7 2042.7 2069.9 2109.1 2113.4 2143.2 1049.7 1119.3 1160.4 1163.8 1172.2 19923.9 19982.0 20154.5 20602.3 21095.6 1087.0 1123.2 1166.7 1168.2 1199.0 11674.9 11756.8 11884.6 11923.8 11959.7 418060.0 422443.0 426302.0 523034.0 538236.0 109455.0 111964.4 112552.4 113391.4 114252.4 1092.2 1093.4 1100.9 1127.8 1131.8 18057.3 18483.3 18713.8 18753.3 18768.4 44356.6 45536.0 45633.3 46379.3 46535.8 63445.7 63792.7 65145.0 65361.7 65435.0 8032.1 8337.9 8623.2 9066.9 9425.8 13466.4 13723.2 14217.8 14391.0 14453.1 12516.7 12522.3 12601.2 12668.6 12857.2 12352.3 12537.2 12817.2 12837.2 12844.6 6306.4 11207.5 12211.0 12973.3 13297.6 8407.3 8448.6 8564.2 8628.9 8697.6 12792.1 12849.7 12872.3 12890.1 12941.1 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#3] mootools.html Cycles:180 Average:6295.88 Median:4768.16 stddev:3649.89 (76.5%) stddev-sans-first:3642.82 01:38:06 INFO - PROCESS | 9633 | Values: 1566.1 1606.8 1793.3 1893.9 1916.3 8277.7 8963.7 9011.5 9620.0 9644.6 9138.4 9203.1 9243.7 9320.7 9326.7 2474.0 2496.1 2507.3 2510.7 2515.2 2443.4 2482.5 2487.7 2492.0 2498.1 2412.8 2436.5 2459.0 2468.8 2469.8 2355.3 2377.3 2395.5 2419.7 2421.1 2353.9 2355.3 2374.7 2379.8 2421.9 9364.7 9382.4 9386.2 9460.1 9476.7 5776.0 5900.2 5905.1 5905.6 5905.9 3515.5 3653.6 3689.7 3696.9 3710.6 1135.3 1172.8 1173.5 1175.0 1202.5 12864.1 12990.2 13002.7 13030.3 13105.8 4871.9 4973.6 5022.0 5120.4 5136.0 11201.0 11324.5 11388.7 11392.7 11405.2 5726.8 5856.9 5911.4 5926.9 5934.3 4664.4 5214.8 5426.3 5430.2 5468.5 4387.7 4407.4 4443.0 4455.7 4505.4 1402.9 1427.6 1428.6 1445.9 1464.7 1017.1 1041.8 1044.7 1048.3 1048.6 6040.5 6119.8 6219.4 6336.8 6359.7 502.8 506.2 510.7 511.9 514.1 4244.7 4263.8 4264.7 4265.5 4269.9 11689.4 11919.9 11954.7 12023.5 12044.3 11903.8 12014.4 12409.8 12552.9 12577.1 8557.7 8897.3 8957.5 9148.2 9310.6 6310.1 6501.8 6523.4 6573.2 6615.5 11304.7 11402.1 11489.3 11534.8 11628.2 11195.2 11220.0 11357.9 11407.9 11530.8 7897.4 8478.9 8643.9 8734.4 8935.5 9713.6 9760.3 9803.1 9852.3 9910.5 8320.3 8385.1 8403.6 8425.9 8467.7 8358.1 8379.3 8404.0 8427.2 8697.4 7133.1 7209.6 7213.8 7253.5 7263.6 5421.5 5452.4 5476.1 5580.9 5621.3 5295.5 5430.2 5440.4 5440.8 5458.4 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#4] prototype.html Cycles:180 Average:5016.96 Median:5630.16 stddev:1493.99 (26.5%) stddev-sans-first:1456.61 01:38:06 INFO - PROCESS | 9633 | Values: 353.9 358.6 363.3 369.4 370.7 5624.7 5653.8 5806.0 5824.4 5851.8 5695.6 5699.6 5699.9 5708.5 5714.6 4459.3 4461.4 4479.9 4486.9 4487.6 4395.3 4471.3 4471.7 4489.7 4495.3 4413.6 4416.2 4422.6 4443.0 4450.7 4298.7 4368.3 4440.7 4472.0 4486.7 3866.6 3877.1 3882.0 3899.6 3902.2 5511.7 5525.0 5554.5 5562.4 5579.2 4898.4 5098.1 5113.9 5120.0 5126.4 5998.4 6001.9 6003.7 6008.5 6039.0 4311.9 4312.4 4327.2 4330.5 4346.0 6182.6 6289.8 6350.8 6351.3 6382.0 4387.7 4410.4 4424.5 4428.3 4445.8 4454.5 4456.2 4481.7 4508.1 4509.9 4989.4 5116.8 5121.3 5151.0 5167.1 5865.8 6030.4 6039.9 6054.7 6091.1 1539.6 1547.9 1547.9 1553.5 1560.0 970.5 984.4 985.8 988.4 1006.6 5230.9 5260.7 5274.9 5278.5 5279.4 5507.2 5533.5 5609.5 5611.5 5635.7 4967.9 5127.6 5228.4 5252.3 5268.5 2888.8 2968.6 2988.2 3014.4 3014.7 5636.0 5648.3 5652.7 5653.5 5690.8 5938.0 6413.7 6435.1 6443.9 6462.7 6408.7 6433.5 6443.9 6456.8 6465.0 6097.4 6264.8 6303.0 6339.6 6364.5 6187.3 6213.4 6225.8 6228.0 6251.7 6327.8 6431.9 6483.6 6484.1 6493.8 4348.3 4378.5 4381.5 4384.5 4456.9 6126.6 6255.5 6264.9 6268.8 6290.2 6071.4 6105.5 6118.7 6127.6 6133.4 6070.8 6100.5 6101.8 6137.7 6145.3 5882.3 6008.6 6009.1 6017.7 6025.5 6083.8 6096.4 6173.7 6178.4 6193.3 5854.3 5899.2 5949.7 6002.6 6011.9 01:38:06 INFO - PROCESS | 9633 | 01:38:06 INFO - PROCESS | 9633 | [#5] yui.html Cycles:180 Average:20381.59 Median:4141.65 stddev:28256.29 (682.2%) stddev-sans-first:28297.25 01:38:06 INFO - PROCESS | 9633 | Values: 787.4 806.9 807.3 861.7 914.8 16713.7 17538.2 17549.7 17611.6 17651.0 16162.5 16249.4 16328.6 16334.9 16335.8 720.8 843.2 862.3 870.5 872.3 858.6 861.4 861.4 865.4 867.0 909.6 909.7 914.0 917.5 919.6 902.6 907.5 910.6 912.3 916.0 670.3 670.9 671.9 673.7 674.8 15789.3 15866.8 15919.5 15942.8 15982.7 15727.0 16243.5 16324.5 16502.3 16619.0 13100.4 13264.6 13293.8 13315.5 13424.0 4003.6 4035.1 4039.7 4117.6 4124.0 75012.0 75727.6 79307.6 84338.0 84497.0 10452.6 10775.0 10881.8 12399.0 12578.4 20977.7 21026.6 21115.6 21264.1 21402.1 8647.6 8665.7 8722.3 8879.9 8886.4 4923.6 4933.7 5044.7 5080.5 5084.3 3911.6 4080.7 4095.1 4122.0 4159.3 665.8 671.5 671.8 681.3 690.3 754.3 829.6 841.6 850.3 874.9 10551.7 10788.2 10896.7 10947.4 11147.2 630.9 685.3 751.5 803.1 809.7 5029.3 5070.7 5119.7 5213.5 5217.2 79138.5 79903.0 81071.0 119140.4 120099.4 102598.0 103545.5 103655.0 104105.0 107113.0 60487.0 61040.0 61311.7 61807.4 63171.0 9139.6 9331.8 9354.5 9570.8 9601.3 53197.5 53683.7 53810.0 54960.7 57250.0 73721.6 80928.0 82070.0 82887.0 84965.0 12986.0 12994.9 13003.2 13159.5 13167.9 13243.1 13340.8 14161.9 14243.3 14784.6 13379.3 13466.9 13849.4 13898.4 13947.3 12963.5 13033.3 13148.6 13238.7 13267.3 12928.5 13763.6 14193.3 14195.8 14972.8 10704.7 10893.8 10982.9 11072.1 11098.2 11302.4 11726.4 11774.9 11791.3 11911.4 01:38:06 INFO - PROCESS | 9633 | -------- Summary: end -------- 01:38:06 INFO - PROCESS | 9633 | 01:38:07 INFO - TEST-INFO | 9633: exit 0 01:38:07 INFO - TEST-OK | dromaeo_css | took 1110472ms 01:38:07 INFO - TEST-START | kraken 01:38:07 INFO - operating with platform_type : linux_ 01:38:07 INFO - Initialising browser for kraken test... 01:38:07 INFO - TEST-INFO | started process 9876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpftb8IP/profile http://localhost:45297/getInfo.html) 01:38:12 INFO - PROCESS | 9876 | __metrics Screen width/height:1600/1200 01:38:12 INFO - PROCESS | 9876 | colorDepth:24 01:38:12 INFO - PROCESS | 9876 | Browser inner width/height: 1024/697 01:38:12 INFO - PROCESS | 9876 | __metrics 01:38:12 ERROR - PROCESS | 9876 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:38:13 INFO - TEST-INFO | 9876: exit 0 01:38:13 INFO - Browser initialized. 01:38:13 INFO - Running cycle 1/1 for kraken test... 01:38:13 INFO - TEST-INFO | started process 10005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpftb8IP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:25 INFO - PROCESS | 10005 | RSS: Main: 155959296 01:38:25 INFO - PROCESS | 10005 | 01:38:27 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45297/tests/kraken/driver.html?testName=audio-beat-detection) 01:38:28 INFO - PROCESS | 10005 | RSS: Main: 161189888 01:38:28 INFO - PROCESS | 10005 | 01:38:31 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45297/tests/kraken/driver.html?testName=audio-dft) 01:38:31 INFO - PROCESS | 10005 | RSS: Main: 160092160 01:38:31 INFO - PROCESS | 10005 | 01:38:34 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45297/tests/kraken/driver.html?testName=audio-fft) 01:38:35 INFO - PROCESS | 10005 | RSS: Main: 161210368 01:38:35 INFO - PROCESS | 10005 | 01:38:37 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45297/tests/kraken/driver.html?testName=audio-oscillator) 01:38:38 INFO - PROCESS | 10005 | RSS: Main: 161345536 01:38:38 INFO - PROCESS | 10005 | 01:38:40 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:38:40 INFO - PROCESS | 10005 | RSS: Main: 161058816 01:38:40 INFO - PROCESS | 10005 | 01:38:43 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45297/tests/kraken/driver.html?testName=imaging-darkroom) 01:38:44 INFO - PROCESS | 10005 | RSS: Main: 160645120 01:38:44 INFO - PROCESS | 10005 | 01:38:47 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45297/tests/kraken/driver.html?testName=imaging-desaturate) 01:38:48 INFO - PROCESS | 10005 | RSS: Main: 161296384 01:38:48 INFO - PROCESS | 10005 | 01:38:51 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45297/tests/kraken/driver.html?testName=json-parse-financial) 01:38:52 INFO - PROCESS | 10005 | RSS: Main: 161427456 01:38:52 INFO - PROCESS | 10005 | 01:38:53 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:38:54 INFO - PROCESS | 10005 | RSS: Main: 161198080 01:38:54 INFO - PROCESS | 10005 | 01:38:55 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:38:56 INFO - PROCESS | 10005 | RSS: Main: 161157120 01:38:56 INFO - PROCESS | 10005 | 01:38:58 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:38:59 INFO - PROCESS | 10005 | RSS: Main: 161517568 01:38:59 INFO - PROCESS | 10005 | 01:39:01 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:02 INFO - PROCESS | 10005 | RSS: Main: 161697792 01:39:02 INFO - PROCESS | 10005 | 01:39:05 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:05 INFO - PROCESS | 10005 | RSS: Main: 161579008 01:39:05 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:45297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45297/tests/kraken/driver.html?testName=ai-astar) 01:39:07 INFO - PROCESS | 10005 | RSS: Main: 162168832 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | __start_tp_report 01:39:07 INFO - PROCESS | 10005 | _x_x_mozilla_page_load 01:39:07 INFO - PROCESS | 10005 | _x_x_mozilla_page_load_details 01:39:07 INFO - PROCESS | 10005 | |i|pagename|runs| 01:39:07 INFO - PROCESS | 10005 | |0;ai-astar;110;103;112;110;113;111;109;109;112;111 01:39:07 INFO - PROCESS | 10005 | |1;audio-beat-detection;154;123;152;177;132;159;150;126;179;126 01:39:07 INFO - PROCESS | 10005 | |2;audio-dft;162;162;161;162;161;164;163;162;163;167 01:39:07 INFO - PROCESS | 10005 | |3;audio-fft;76;76;76;169;77;76;76;75;164;75 01:39:07 INFO - PROCESS | 10005 | |4;audio-oscillator;85;84;141;84;85;85;129;87;84;154 01:39:07 INFO - PROCESS | 10005 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 01:39:07 INFO - PROCESS | 10005 | |6;imaging-darkroom;147;147;147;146;147;148;147;147;147;147 01:39:07 INFO - PROCESS | 10005 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;95;96 01:39:07 INFO - PROCESS | 10005 | |8;json-parse-financial;53;52;54;52;53;55;53;52;52;55 01:39:07 INFO - PROCESS | 10005 | |9;json-stringify-tinderbox;60;61;60;60;61;61;60;61;61;60 01:39:07 INFO - PROCESS | 10005 | |10;stanford-crypto-aes;77;76;78;76;82;79;84;81;107;77 01:39:07 INFO - PROCESS | 10005 | |11;stanford-crypto-ccm;120;128;120;132;121;130;132;118;130;120 01:39:07 INFO - PROCESS | 10005 | |12;stanford-crypto-pbkdf2;157;153;153;153;151;151;152;158;156;155 01:39:07 INFO - PROCESS | 10005 | |13;stanford-crypto-sha256-iterative;62;64;62;62;64;66;67;61;62;65 01:39:07 INFO - PROCESS | 10005 | __end_tp_report 01:39:07 INFO - PROCESS | 10005 | __start_cc_report 01:39:07 INFO - PROCESS | 10005 | _x_x_mozilla_cycle_collect,873 01:39:07 INFO - PROCESS | 10005 | __end_cc_report 01:39:07 INFO - PROCESS | 10005 | __startTimestamp1467103147625__endTimestamp 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | ------- Summary: start ------- 01:39:07 INFO - PROCESS | 10005 | Number of tests: 14 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.79 (2.5%) stddev-sans-first:2.96 01:39:07 INFO - PROCESS | 10005 | Values: 110.0 103.0 112.0 110.0 113.0 111.0 109.0 109.0 112.0 111.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.00 stddev:20.62 (13.5%) stddev-sans-first:21.75 01:39:07 INFO - PROCESS | 10005 | Values: 154.0 123.0 152.0 177.0 132.0 159.0 150.0 126.0 179.0 126.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.77 (1.1%) stddev-sans-first:1.86 01:39:07 INFO - PROCESS | 10005 | Values: 162.0 162.0 161.0 162.0 161.0 164.0 163.0 162.0 163.0 167.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.23 (50.3%) stddev-sans-first:39.99 01:39:07 INFO - PROCESS | 10005 | Values: 76.0 76.0 76.0 169.0 77.0 76.0 76.0 75.0 164.0 75.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:84.50 stddev:27.92 (33.0%) stddev-sans-first:28.95 01:39:07 INFO - PROCESS | 10005 | Values: 85.0 84.0 141.0 84.0 85.0 85.0 129.0 87.0 84.0 154.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:39:07 INFO - PROCESS | 10005 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 01:39:07 INFO - PROCESS | 10005 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 147.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:39:07 INFO - PROCESS | 10005 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 01:39:07 INFO - PROCESS | 10005 | Values: 53.0 52.0 54.0 52.0 53.0 55.0 53.0 52.0 52.0 55.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 01:39:07 INFO - PROCESS | 10005 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 60.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:78.50 stddev:9.29 (11.8%) stddev-sans-first:9.69 01:39:07 INFO - PROCESS | 10005 | Values: 77.0 76.0 78.0 76.0 82.0 79.0 84.0 81.0 107.0 77.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:129.00 stddev:5.74 (4.5%) stddev-sans-first:5.79 01:39:07 INFO - PROCESS | 10005 | Values: 120.0 128.0 120.0 132.0 121.0 130.0 132.0 118.0 130.0 120.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:2.47 (1.6%) stddev-sans-first:2.35 01:39:07 INFO - PROCESS | 10005 | Values: 157.0 153.0 153.0 153.0 151.0 151.0 152.0 158.0 156.0 155.0 01:39:07 INFO - PROCESS | 10005 | 01:39:07 INFO - PROCESS | 10005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.06 01:39:07 INFO - PROCESS | 10005 | Values: 62.0 64.0 62.0 62.0 64.0 66.0 67.0 61.0 62.0 65.0 01:39:07 INFO - PROCESS | 10005 | -------- Summary: end -------- 01:39:07 INFO - PROCESS | 10005 | 01:39:08 INFO - TEST-INFO | 10005: exit 0 01:39:08 INFO - TEST-OK | kraken | took 61148ms 01:39:08 INFO - SUITE-END | took 1171s 01:39:08 INFO - Completed test suite (00:19:31) 01:39:08 INFO - javascript benchmark 01:39:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7847.40122649002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3451.8791842285523, 3462.2383075723333, 3480.356134115188, 3481.912952176197, 3484.738644601654, 5841.591088623798, 5848.356680765112, 5884.794032208873, 5902.468777809991, 5960.582759206857, 5845.941540584593, 5865.472107510323, 5919.1713160157615, 5924.911126333109, 5940.405959404057, 5284.313039304895, 5328.92006619901, 5399.271098401724, 5406.59450541209, 5429.701366424845, 5275.287836142129, 5275.472452754713, 5316.096263635172, 5443.863903402407, 5446.754896029688, 5320.680759154463, 5341.06531357013, 5350.35795704516, 5354.9196762048605, 5383.81156659517, 5399.325084364474, 5401.054815407328, 5406.459354064562, 5421.972890135544, 5436.91844622331, 5056.924146137811, 5232.895342093175, 5251.711155886424, 5276.918231762479, 5302.1781623848365, 5745.454181852718, 5750.626209296424, 5786.508146807484, 5792.710364481801, 5801.50687191585, 6359.713812878385, 6368.203974503187, 6382.712777925005, 6395.616263024233, 6409.134766806468, 6199.783007594758, 6260.373962603749, 6302.0, 6302.653354065525, 6441.935580644227, 5914.201582786269, 5914.615549989237, 5916.230889984317, 5916.7337469813965, 5932.703364831785, 6451.451701564121, 6471.546991710629, 6474.5791523550815, 6475.4819614430735, 6488.545801793829, 5981.820545383645, 6134.04922237054, 6158.692065396802, 6158.815235542941, 6243.125962365272, 6318.241810982711, 6343.238811342669, 6376.553641245068, 6381.202349706286, 6384.07430922523, 6138.048602466625, 6330.493560515148, 6332.8416789579705, 6338.619682819046, 6349.587276826992, 6216.502679785606, 6236.0, 6256.468200203034, 6329.367063293726, 6344.175257216532, 4775.092732380836, 4777.593904518086, 4793.400824896888, 4797.808087676523, 4819.132556139858, 4227.915441691211, 4260.893477663083, 4284.335927931175, 4287.206866729665, 4292.184484947912, 5861.912071318934, 5931.139984702194, 5955.225820643375, 6081.75672973085, 6088.543359248074, 6306.558540902184, 6312.242530896322, 6330.8100756977365, 6340.1440805490665, 6341.365863413714, 5859.589828711949, 5993.310769261503, 6007.969960150172, 6019.578629495893, 6048.0625503047095, 5431.972840135774, 5433.972830135824, 5443.673379597237, 5446.373667028342, 5463.9180412293845, 6573.112629795012, 6605.339466053452, 6610.0, 6618.669066546653, 6636.966815165893, 6143.938560614337, 6206.131141640084, 6217.844553886189, 6273.3099359071375, 6404.423601875854, 6528.37980391862, 6544.44372228366, 6556.80329590094, 6581.3418658133805, 6585.934140658532, 6246.906296405648, 6249.25008998923, 6250.843728906813, 6260.561760676709, 6267.0, 6145.740123274629, 6277.089821975879, 6283.3402492737605, 6344.175257216532, 6440.484761218998, 6194.5354098443695, 6199.256089269316, 6205.875882482415, 6255.40573645503, 6278.246610406781, 6022.307434645072, 6188.257409110755, 6246.281677606951, 6253.530985176221, 6253.593516421418, 6051.394860513913, 6071.817845464643, 6077.817665470043, 6138.846528836636, 6153.446189842935, 6228.4705800007505, 6233.252009758858, 6250.406211409909, 6253.343398943045, 6274.341194174728, 5886.499647530008, 6005.7297421617, 6059.939510585718, 6085.3306136325855, 6118.755249789959], "value": 5817.044186937872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3850848845979, 620.0544170140536, 637.9601249962558, 648.2286079565317, 680.3808534233848, 43394.0, 47573.762131189294, 47581.286280705775, 47747.28379074308, 47859.28211076832, 48296.0, 48406.75796621021, 48711.0, 48855.75572122143, 48873.26690099651, 9121.0, 9152.771180720469, 9204.815903681922, 9215.308851836106, 9245.0, 9103.226225770817, 9125.817483650322, 9135.26917846574, 9199.264058875307, 9225.769355766093, 9088.409253398508, 9196.218321442686, 9209.0, 9256.72229833106, 9258.6296548138, 9202.125798049208, 9234.722958311228, 9234.815303693922, 9246.722598321994, 9262.212711919496, 8966.730998070068, 9034.954825225897, 9043.728688139367, 9055.547222638908, 9062.546872656341, 45666.08667826658, 45808.54191458076, 45855.54144458546, 45900.311495327594, 46106.0, 3763.9623603764157, 3975.4434379186937, 3980.024893900984, 4069.9796501017304, 4527.071950250223, 34470.0, 35106.0, 35426.46860297098, 35603.0, 35619.10952226189, 4700.177468942921, 4797.544233297831, 4800.759962001921, 4809.062232864593, 4869.342638743759, 400185.0, 400448.0, 400536.0, 401295.0, 401342.0, 68553.65723171353, 69009.0, 69126.65436672785, 69145.3085469149, 69292.0, 40017.0, 41116.794416027726, 41245.58754412478, 42880.571194288284, 72571.0, 19764.60470790576, 19917.10373033217, 19960.500987475138, 20090.799092009183, 20093.39719808408, 15442.691146177238, 15590.610234743996, 15700.136492493022, 15701.0, 15724.371025158865, 21813.78186218149, 21896.343109706733, 21998.0, 22026.11895524161, 22136.88931555332, 7946.602669866484, 7968.521888686697, 7975.8404831903035, 8023.277904988579, 8024.598770061473, 1023.4626820918928, 1070.6573896353248, 1083.9349639021684, 1084.8860869608577, 1102.2835157147758, 34690.82654586761, 35496.0, 35971.64028359735, 38595.22809543793, 38666.42000369997, 1153.5962413155496, 1172.888575585318, 1198.4846515998204, 1224.7550489902055, 1258.3959699344182, 17972.640547188985, 18344.174512146987, 18379.356722514647, 18517.259309627734, 18525.166367513495, 973352.0, 986352.0, 988651.0, 995141.0, 1052821.0, 63350.683246583474, 63372.68313658402, 63620.36379636237, 63809.680951595874, 64528.35471645317, 1507.7512210485147, 1514.674345015827, 1522.5584580471539, 1527.4348491058158, 1537.569480545449, 32690.34619307553, 33838.66161338355, 33848.0, 34010.489842652874, 34981.0, 56043.15935261056, 56671.0, 56672.43327566671, 56789.71605141948, 64380.35619643744, 425947.0, 557121.0, 562998.0, 564889.0, 571550.0, 49176.75411622919, 49230.26154607612, 49729.50270497249, 50323.24515132349, 51066.23400648919, 55998.16002760043, 56407.43592564186, 57217.0, 57326.7133664329, 58190.0, 47500.0, 47764.28353574769, 47797.0, 48102.0, 48875.51124488709, 46524.767376162905, 47363.52636473729, 47902.28146577734, 48270.517294826604, 48298.75850620725, 47110.52889471062, 47279.763601181774, 48475.27287090626, 48501.75749121373, 48655.75672121617, 39546.0, 40061.79969100136, 40516.0, 40770.38844417396, 40883.0, 31019.534706979866, 31148.68851311458, 31388.68611313949, 31809.840950795096, 31845.0], "value": 22782.89348246371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.42323286795687, 433.59242312226513, 433.670410488029, 438.4705987152713, 448.97306161630286, 18422.53943651408, 19886.801131988694, 20258.594828103447, 21389.786102138973, 21438.24966126186, 19570.412887613395, 20074.89962550189, 20772.06525706343, 20857.26999555016, 20900.16399344028, 5849.912251316234, 6018.247719035121, 6043.093535969596, 6046.455818976291, 6060.181875446824, 5667.829965101054, 5820.796272130477, 5863.79476718315, 5883.970580147115, 5900.350961394243, 5759.539236861062, 5796.391378905218, 5811.506021988136, 5823.737931793058, 5837.5913686041995, 5626.634268772516, 5898.144769008512, 5906.763729450817, 5909.320428150775, 5915.408459154093, 5275.630705850592, 5301.125314323132, 5303.071962406563, 5313.1764576490705, 5318.44156363584, 23723.0, 23833.761662383327, 23988.160414385588, 24438.633420498707, 24535.877320613283, 2501.9874900625564, 2543.173468622705, 2576.896924123033, 2822.417487998479, 2832.3202431416516, 15483.5354939352, 15610.375584976588, 15653.217339132998, 15673.216339182994, 16025.679486410323, 2041.3467690339098, 2051.8563700540967, 2084.6351888419467, 2133.7546182188935, 2179.095675294751, 83922.0, 85579.5721021391, 85584.14415855824, 86269.0, 86865.99999999937, 11163.553457861595, 11362.431878406047, 11427.60003399877, 11561.942190289163, 11887.346195959306, 16373.0, 16384.508464746075, 16518.174091295386, 16528.586785330463, 16571.42000029993, 8821.117888211127, 8863.601137948808, 8920.330975176888, 9075.863862042075, 9456.05439456049, 8496.70261540843, 8605.612747426381, 8624.69813556535, 8663.653453861902, 8834.602442890086, 7086.326798954091, 7150.10623672041, 7197.4961752677855, 7268.200497945222, 7327.670254838545, 2042.7344445222027, 2069.9093915145813, 2109.124713244017, 2113.3765539165984, 2143.20701340505, 1049.7218237167158, 1119.3172164979355, 1160.3733983648735, 1163.7963356412595, 1172.1501911114544, 19923.900380498006, 19982.0, 20154.496137596383, 20602.27892023772, 21095.578088438146, 1086.9891301087046, 1123.1688550472754, 1166.690826930864, 1168.2056201782868, 1198.9880101198876, 11674.88325116755, 11756.823647645293, 11884.643460696192, 11923.761524769456, 11959.701007474883, 418060.0, 422443.0, 426302.0, 523034.0, 538236.0, 109455.0, 111964.44017779859, 112552.43723781493, 113391.43304283591, 114252.42873785744, 1092.229977865603, 1093.4314156638504, 1100.9119270458343, 1127.774445110981, 1131.8472006279046, 18057.277708891495, 18483.260669573065, 18713.812861871753, 18753.34363297278, 18768.436946891616, 44356.556434436534, 45536.0, 45633.31550026686, 46379.30431043605, 46535.76732116318, 63445.682771585845, 63792.68103659452, 65145.02282465672, 65361.67319163374, 65435.0, 8032.076311224284, 8337.94889451086, 8623.223909848144, 9066.863997039918, 9425.811483770423, 13466.394012269275, 13723.245221512912, 14217.786733198804, 14391.0, 14453.132812031312, 12516.749665006831, 12522.311272880079, 12601.18092323996, 12668.556600518938, 12857.164284321489, 12352.320622365856, 12537.247765134121, 12817.23096614206, 12837.165584236995, 12844.614661560168, 6306.400891915261, 11207.49566269536, 12211.0, 12973.286469244282, 13297.601071967856, 8407.327413807003, 8448.577571121543, 8564.229219370287, 8628.870566941627, 8697.608607612547, 12792.104552681223, 12849.678758031125, 12872.292023938773, 12890.097693161764, 12941.094123411647], "value": 10028.888533214862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.1284764706177, 1606.7830842836217, 1793.2647614478067, 1893.8768980016307, 1916.27181670965, 8277.710280140196, 8963.686270980517, 9011.549422528871, 9619.951900240498, 9644.565994530245, 9138.40600360976, 9203.079692030811, 9243.722688319345, 9320.72037838866, 9326.72019839406, 2474.047491715689, 2496.051500429834, 2507.285423654259, 2510.686164229471, 2515.157422263544, 2443.4380092578717, 2482.5407299649623, 2487.7387874273213, 2491.9750802492017, 2498.100683753847, 2412.7828495435406, 2436.537057958982, 2458.9754102459015, 2468.8395254308502, 2469.7900678442265, 2355.34050465869, 2377.3105799318178, 2395.5448464791634, 2419.733829278778, 2421.128393778238, 2353.8940747666397, 2355.316958082154, 2374.7150341959077, 2379.773921477457, 2421.8546887186826, 9364.672236471759, 9382.437053776795, 9386.249100071978, 9460.053994600554, 9476.715698529055, 5775.971120144372, 5900.203472531196, 5905.114232865061, 5905.557083218776, 5905.881882362329, 3515.54297941266, 3653.6346365363515, 3689.7232707546773, 3696.9075773105887, 3710.5547334320054, 1135.3188087147646, 1172.8006238939315, 1173.4778023779422, 1175.0, 1202.5129822421934, 12864.09951303409, 12990.155639883471, 13002.674933126653, 13030.348482575833, 13105.803412948813, 4871.926921096187, 4973.626977976666, 5021.974890125526, 5120.4111527174855, 5136.0, 11201.0, 11324.490397932113, 11388.65834024964, 11392.715182120513, 11405.201635885574, 5726.828195154152, 5856.8535786604825, 5911.379305172981, 5926.881462370815, 5934.317553481319, 4664.39362882823, 5214.817481388133, 5426.321709786277, 5430.15832545956, 5468.535174510132, 4387.670924680661, 4407.449068866392, 4443.0, 4455.710378825366, 4505.391772110788, 1402.880755135825, 1427.6145440731152, 1428.5928510374492, 1445.8554144585667, 1464.6704491489543, 1017.0998666180484, 1041.7864337810731, 1044.6604853422668, 1048.339546085961, 1048.6224959014748, 6040.486558642565, 6119.816405507842, 6219.440250377488, 6336.8415789604705, 6359.650219237894, 502.8214983680814, 506.2254750232077, 510.6578592343139, 511.8541215753492, 514.0926265142027, 4244.724092934011, 4263.765492897858, 4264.722793018444, 4265.50946641134, 4269.893252668709, 11689.415529223676, 11919.940400297943, 11954.701132471759, 12023.519059237708, 12044.277343359427, 11903.761924761457, 12014.399280035963, 12409.813852792035, 12552.937235313764, 12577.119601627799, 8557.657693692183, 8897.332700047393, 8957.507337096393, 9148.222401095849, 9310.581023853943, 6310.148130002574, 6501.772437964649, 6523.445507131947, 6573.211214654272, 6615.503837212132, 11304.676391333287, 11402.087832973508, 11489.253198542068, 11534.769304614028, 11628.244164129304, 11195.160362972647, 11220.0, 11357.886421135683, 11407.885921140682, 11530.82703759461, 7897.368210543258, 8478.872816907875, 8643.91356086431, 8734.388592798443, 8935.508547029976, 9713.611455541699, 9760.267979901679, 9803.068708472683, 9852.261080418853, 9910.504474776088, 8320.334373250005, 8385.077641459557, 8403.579821008803, 8425.87361189595, 8467.703630372907, 8358.080611132893, 8379.329653627574, 8404.0, 8427.157284271523, 8697.391182617155, 7133.108361454818, 7209.567425954459, 7213.819654508679, 7253.528520646141, 7263.636818158965, 5421.5391691706645, 5452.427495112956, 5476.0690682584855, 5580.9441905580425, 5621.269234999424, 5295.470452954673, 5430.185472179047, 5440.401555828935, 5440.782368705208, 5458.372287187024], "value": 4930.775895893672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8973697627687, 358.5625536845049, 363.25895173845356, 369.41078979028475, 370.6515875077427, 5624.650083979846, 5653.816176029729, 5805.98088993723, 5824.359320474744, 5851.824445266643, 5695.629784064033, 5699.629524080942, 5699.914501282484, 5708.4862362387485, 5714.57140714446, 4459.264221403465, 4461.375407442961, 4479.865604031885, 4486.865394038184, 4487.596116349528, 4395.274779661368, 4471.306947423138, 4471.66462515311, 4489.7449349221715, 4495.303227999649, 4413.6027757501815, 4416.249237629595, 4422.601965823092, 4443.045060173529, 4450.666200035011, 4298.677599180042, 4368.279233926399, 4440.735225035255, 4472.0, 4486.708363956365, 3866.5940076291868, 3877.1470276539117, 3882.0294926268434, 3899.590542992973, 3902.2195560887653, 5511.696856672881, 5524.972375138139, 5554.527865131468, 5562.3881373048935, 5579.191017302509, 4898.40384596161, 5098.056859480971, 5113.923291150636, 5120.0, 5126.410462796789, 5998.40015998401, 6001.909971350433, 6003.699815009232, 6008.459238668541, 6038.96980515099, 4311.935320970188, 4312.3531470279395, 4327.156204540116, 4330.458692663417, 4346.0, 6182.557889633615, 6289.779857705004, 6350.809475715736, 6351.333110023427, 6382.0, 4387.670924680661, 4410.404595379647, 4424.4956714717155, 4428.31361139024, 4445.777711114431, 4454.532274111237, 4456.197884380843, 4481.731096134243, 4508.120916421266, 4509.864704058883, 4989.351384320088, 5116.846494605168, 5121.308623335876, 5150.995555866645, 5167.121589329823, 5865.765369385262, 6030.3668114847305, 6039.939600604026, 6054.697265136726, 6091.14723938649, 1539.6074001129641, 1547.8529539693711, 1547.9303431345616, 1553.5339398180502, 1560.0, 970.5292932927524, 984.4241118945354, 985.7683444390562, 988.3921388346115, 1006.6476733143342, 5230.947690523122, 5260.736963151904, 5274.947250527523, 5278.4721527846905, 5279.392869819943, 5507.201455788888, 5533.501984821385, 5609.523190528769, 5611.494965453129, 5635.675616230183, 4967.907060446696, 5127.564157046693, 5228.424873263938, 5252.343457067866, 5268.525832675001, 2888.768898488116, 2968.6289213848268, 2988.237999310162, 3014.3971205758935, 3014.6834582368974, 5635.971820140873, 5648.265725455664, 5652.74562644682, 5653.519450846724, 5690.772369105272, 5938.0, 6413.6793160341795, 6435.101645014732, 6443.935560644427, 6462.676866156768, 6408.711607977559, 6433.485321174388, 6443.935560644427, 6456.806295811133, 6465.0, 6097.390260973867, 6264.812055638338, 6302.968485157545, 6339.5562310637815, 6364.459020983269, 6187.288461826767, 6213.440790328892, 6225.844353891189, 6227.96886015567, 6251.749930002931, 6327.810165694852, 6431.903521447276, 6483.643399612878, 6484.1246431731115, 6493.772717954849, 4348.2825333819565, 4378.474583050054, 4381.474223093249, 4384.473863136444, 4456.888577785581, 6126.632402055891, 6255.530835187288, 6264.906026409516, 6268.780592679234, 6290.24517057956, 6071.423214794588, 6105.511559075352, 6118.653896142841, 6127.601705889103, 6133.3866613338305, 6070.785842831363, 6100.511959043177, 6101.7559297627595, 6137.723802428812, 6145.293291271382, 5882.323532793613, 6008.579399442172, 6009.098635204754, 6017.699115044318, 6025.457708806229, 6083.813656337149, 6096.390360963868, 6173.6913154343, 6178.41305076017, 6193.287771906288, 5854.297484301911, 5899.1730596792895, 5949.691067965214, 6002.609830361012, 6011.939880601313], "value": 4541.930056697427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.3897729259819, 806.9314108300794, 807.2613558593887, 861.67687117331, 914.7530166854949, 16713.665726685475, 17538.21078051486, 17549.73675394867, 17611.64776704465, 17651.02919339436, 16162.515124546253, 16249.431269905555, 16328.591785205375, 16334.918325408356, 16335.754963675554, 720.805382546712, 843.2326582809644, 862.3273846399818, 870.4603146049427, 872.3326655108815, 858.6179150278128, 861.3711990247092, 861.4314552395421, 865.446114486729, 867.0072766682146, 909.6225066597354, 909.6816114359988, 914.0037359278385, 917.4724533393293, 919.6413398774483, 902.6028547439106, 907.4555266839843, 910.6266430763388, 912.2747415804386, 916.029009250197, 670.2761018100489, 670.8557660103102, 671.8824205763972, 673.737242475435, 674.7739507265072, 15789.28948197334, 15866.761998570031, 15919.522414327588, 15942.840571594252, 15982.680346393006, 15727.019248514936, 16243.51269461918, 16324.510264692079, 16502.2573984171, 16619.0, 13100.410481528354, 13264.602061938158, 13293.800592991112, 13315.533956311483, 13424.0, 4003.619656132663, 4035.0921042765435, 4039.6970227233073, 4117.608827161415, 4124.030852749602, 75012.0, 75727.62136189338, 79307.60346198232, 84338.0, 84497.0, 10452.634157804441, 10775.0, 10881.782364352668, 12399.0, 12578.433970471351, 20977.68533471999, 21026.57946841085, 21115.577688446145, 21264.149434022467, 21402.143914243567, 8647.610857511427, 8665.696700615448, 8722.302215822845, 8879.866801997976, 8886.422382545114, 4923.606111511071, 4933.728644924564, 5044.747762611854, 5080.542751152414, 5084.288199652052, 3911.647951684362, 4080.6735461163034, 4095.140020595649, 4121.9587804122175, 4159.272127377697, 665.7902760630386, 671.4561205423622, 671.7783131566571, 681.2608319972786, 690.2855544511507, 754.3135746470685, 829.5934991854069, 841.6380956188898, 850.3452341696859, 874.9343799215085, 10551.683449496528, 10788.244822862482, 10896.673099807018, 10947.397893115955, 11147.21969462146, 630.9148264984168, 685.3318014935398, 751.4514404484756, 803.1366281247682, 809.680176330358, 5029.321041659329, 5070.670406423571, 5119.718415487184, 5213.530782229617, 5217.165253559412, 79138.45907880476, 79903.0, 81071.0, 119140.40429797796, 120099.39950300193, 102598.0, 103545.48227258815, 103655.0, 104105.0, 107113.0, 60487.0, 61040.0, 61311.693441533396, 61807.38192618016, 63171.0, 9139.63441462334, 9331.813363732552, 9354.53227338644, 9570.808583828424, 9601.279904007368, 53197.46802531925, 53683.731581341846, 53810.0, 54960.72519637536, 57250.0, 73721.6313918427, 80928.0, 82070.0, 82887.0, 84965.0, 12986.0, 12994.895433887847, 13003.154794938298, 13159.47362105505, 13167.868321317048, 13243.07298489135, 13340.799888001493, 14161.858381416054, 14243.287835608386, 14784.556463306119, 13379.331033448483, 13466.93266533661, 13849.376778045214, 13898.444062237802, 13947.30263486842, 12963.481460741465, 13033.348332583522, 13148.60554183376, 13238.735225295633, 13267.336633168496, 12928.547500837425, 13763.587092387244, 14193.29033548339, 14195.787063194268, 14972.775408369102, 10704.678859634223, 10893.78212435731, 10982.890171098186, 11072.058874995393, 11098.223124381217, 11302.43487825622, 11726.41367931617, 11774.882251177722, 11791.29252244868, 11911.404429778304], "value": 7844.971645632145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 112.0, 110.0, 113.0, 111.0, 109.0, 109.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 152.0, 177.0, 132.0, 159.0, 150.0, 126.0, 179.0, 126.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 164.0, 163.0, 162.0, 163.0, 167.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 169.0, 77.0, 76.0, 76.0, 75.0, 164.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 141.0, 84.0, 85.0, 85.0, 129.0, 87.0, 84.0, 154.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 52.0, 53.0, 55.0, 53.0, 52.0, 52.0, 55.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 76.0, 82.0, 79.0, 84.0, 81.0, 107.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 128.0, 120.0, 132.0, 121.0, 130.0, 132.0, 118.0, 130.0, 120.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 153.0, 153.0, 151.0, 151.0, 152.0, 158.0, 156.0, 155.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 64.0, 66.0, 67.0, 61.0, 62.0, 65.0], "value": 63.5, "unit": "score"}]}]} 01:39:08 INFO - Return code: 0 01:39:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:08 ERROR - # TBPL SUCCESS # 01:39:08 INFO - Running post-action listener: _resource_record_post_action 01:39:08 INFO - ##### 01:39:08 INFO - ##### Finished run-tests step (success) 01:39:08 INFO - ##### 01:39:08 INFO - Running post-run listener: _resource_record_post_run 01:39:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504967168; Read time: 32; Write time: 448388 01:39:09 INFO - TinderboxPrint: CPU usage
13.4% 01:39:09 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 01:39:09 INFO - TinderboxPrint: I/O write bytes / time
504,967,168 / 448,388 01:39:09 INFO - TinderboxPrint: CPU idle
8,215.4 (86.6%) 01:39:09 INFO - TinderboxPrint: CPU user
1,213.0 (12.8%) 01:39:09 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252698624; Read time: 0; Write time: 280864 01:39:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252268544; Read time: 32; Write time: 167524 01:39:09 INFO - Running post-run listener: _upload_blobber_files 01:39:09 INFO - Blob upload gear active. 01:39:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:09 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:09 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:09 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:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:10 INFO - (blobuploader) - INFO - Done attempting. 01:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:11 INFO - (blobuploader) - INFO - Done attempting. 01:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:14 INFO - (blobuploader) - INFO - Done attempting. 01:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:14 INFO - Return code: 0 01:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ae021ea824239216c1bdc7343c48c97f8c05aa4c4812afc7176e0e65997c4734465ea30c62d493fb0cafaec64b6809800fb2f562264d8e4589b93b22cf5733b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426b103587c68b3c8eaaa4a8673ea7f8f408290c72e7339dfef1c6ad0875fa94cb4d74a60314de183a293080bba542f989cdc01dfa93ff0f31870466e3037bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ebf9b3f54f99426e89e92a9e032094f88799f60229cc42c3ebfd3f4d61cb89b76b6d2067d6aeeecf86dd0a9bc2fd0dea408805985d712f1606d3b139ffdcc2"} 01:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:14 INFO - Contents: 01:39:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ae021ea824239216c1bdc7343c48c97f8c05aa4c4812afc7176e0e65997c4734465ea30c62d493fb0cafaec64b6809800fb2f562264d8e4589b93b22cf5733b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426b103587c68b3c8eaaa4a8673ea7f8f408290c72e7339dfef1c6ad0875fa94cb4d74a60314de183a293080bba542f989cdc01dfa93ff0f31870466e3037bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ebf9b3f54f99426e89e92a9e032094f88799f60229cc42c3ebfd3f4d61cb89b76b6d2067d6aeeecf86dd0a9bc2fd0dea408805985d712f1606d3b139ffdcc2"} 01:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:14 INFO - Copying logs to upload dir... 01:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.323319 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 01:39:14.736998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:14.741077) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 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/4ae021ea824239216c1bdc7343c48c97f8c05aa4c4812afc7176e0e65997c4734465ea30c62d493fb0cafaec64b6809800fb2f562264d8e4589b93b22cf5733b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426b103587c68b3c8eaaa4a8673ea7f8f408290c72e7339dfef1c6ad0875fa94cb4d74a60314de183a293080bba542f989cdc01dfa93ff0f31870466e3037bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ebf9b3f54f99426e89e92a9e032094f88799f60229cc42c3ebfd3f4d61cb89b76b6d2067d6aeeecf86dd0a9bc2fd0dea408805985d712f1606d3b139ffdcc2"} 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.011416 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/4ae021ea824239216c1bdc7343c48c97f8c05aa4c4812afc7176e0e65997c4734465ea30c62d493fb0cafaec64b6809800fb2f562264d8e4589b93b22cf5733b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4426b103587c68b3c8eaaa4a8673ea7f8f408290c72e7339dfef1c6ad0875fa94cb4d74a60314de183a293080bba542f989cdc01dfa93ff0f31870466e3037bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ebf9b3f54f99426e89e92a9e032094f88799f60229cc42c3ebfd3f4d61cb89b76b6d2067d6aeeecf86dd0a9bc2fd0dea408805985d712f1606d3b139ffdcc2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:14.767429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:14.767809) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467101132.554706-1141617244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:14.851763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:14.852086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:14.852373) ========= ========= Total master_lag: 0.92 =========