builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1467014804.51 results: success (0) buildid: 20160626223041 builduid: fd06654e5282495199a9acdd8dcab8bf revision: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.512727) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.513307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.513677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.529233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.529695) ========= 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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 01:06:45-- 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% 119M=0s 2016-06-27 01:06:45 (119 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.666514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.666889) ========= 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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020004 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.716873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:44.717285) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 --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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 01:06:45,845 truncating revision to first 12 chars 2016-06-27 01:06:45,845 Setting DEBUG logging. 2016-06-27 01:06:45,845 attempt 1/10 2016-06-27 01:06:45,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e68e0c28c1b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 01:06:46,169 unpacking tar archive at: mozilla-inbound-e68e0c28c1b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:45.373083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:45.373477) ========= script_repo_revision: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:45.373989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:45.374303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:06:45.383585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-27 01:06:45.383959) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:06:46 INFO - MultiFileLogger online at 20160627 01:06:46 in /builds/slave/test 01:06:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:06:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:06:46 INFO - {'append_to_log': False, 01:06:46 INFO - 'base_work_dir': '/builds/slave/test', 01:06:46 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:06:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:06:46 INFO - 'branch': 'Mozilla-Inbound', 01:06:46 INFO - 'buildbot_json_path': 'buildprops.json', 01:06:46 INFO - 'config_files': ('talos/linux_config.py',), 01:06:46 INFO - 'default_actions': ('clobber', 01:06:46 INFO - 'read-buildbot-config', 01:06:46 INFO - 'download-and-extract', 01:06:46 INFO - 'populate-webroot', 01:06:46 INFO - 'create-virtualenv', 01:06:46 INFO - 'install', 01:06:46 INFO - 'run-tests'), 01:06:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:06:46 INFO - 'download_minidump_stackwalk': True, 01:06:46 INFO - 'download_symbols': 'ondemand', 01:06:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:06:46 INFO - 'tooltool.py': '/tools/tooltool.py', 01:06:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:06:46 INFO - '/tools/misc-python/virtualenv.py')}, 01:06:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:06:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:06:46 INFO - 'installer_path': 'installer.exe', 01:06:46 INFO - 'log_level': 'info', 01:06:46 INFO - 'log_name': 'talos', 01:06:46 INFO - 'log_to_console': True, 01:06:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:06:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:06:46 INFO - 'opt_config_files': (), 01:06:46 INFO - 'pip_index': False, 01:06:46 INFO - 'sps_profile': False, 01:06:46 INFO - 'sps_profile_interval': 0, 01:06:46 INFO - 'suite': 'dromaeojs', 01:06:46 INFO - 'system_bits': '32', 01:06:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:06:46 INFO - 'title': 'talos-linux64-ix-063', 01:06:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:06:46 INFO - 'use_talos_json': True, 01:06:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:06:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:06:46 INFO - 'work_dir': 'build'} 01:06:46 INFO - ##### 01:06:46 INFO - ##### Running clobber step. 01:06:46 INFO - ##### 01:06:46 INFO - Running pre-action listener: _resource_record_pre_action 01:06:46 INFO - Running main action method: clobber 01:06:46 INFO - rmtree: /builds/slave/test/build 01:06:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:06:47 INFO - Running post-action listener: _resource_record_post_action 01:06:47 INFO - ##### 01:06:47 INFO - ##### Finished clobber step (success) 01:06:47 INFO - ##### 01:06:47 INFO - ##### 01:06:47 INFO - ##### Running read-buildbot-config step. 01:06:47 INFO - ##### 01:06:47 INFO - Running pre-action listener: _resource_record_pre_action 01:06:47 INFO - Running main action method: read_buildbot_config 01:06:47 INFO - Using buildbot properties: 01:06:47 INFO - { 01:06:47 INFO - "project": "", 01:06:47 INFO - "product": "firefox", 01:06:47 INFO - "script_repo_revision": "production", 01:06:47 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:06:47 INFO - "repository": "", 01:06:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:06:47 INFO - "buildid": "20160626223041", 01:06:47 INFO - "pgo_build": "True", 01:06:47 INFO - "basedir": "/builds/slave/test", 01:06:47 INFO - "buildnumber": 1172, 01:06:47 INFO - "slavename": "talos-linux64-ix-063", 01:06:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:06:47 INFO - "platform": "ubuntu64_hw", 01:06:47 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:06:47 INFO - "branch": "mozilla-inbound", 01:06:47 INFO - "repo_path": "integration/mozilla-inbound", 01:06:47 INFO - "revision": "e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436", 01:06:47 INFO - "stage_platform": "linux64-pgo", 01:06:47 INFO - "builduid": "fd06654e5282495199a9acdd8dcab8bf", 01:06:47 INFO - "slavebuilddir": "test" 01:06:47 INFO - } 01:06:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:06:47 INFO - Running post-action listener: _resource_record_post_action 01:06:47 INFO - ##### 01:06:47 INFO - ##### Finished read-buildbot-config step (success) 01:06:47 INFO - ##### 01:06:47 INFO - ##### 01:06:47 INFO - ##### Running download-and-extract step. 01:06:47 INFO - ##### 01:06:47 INFO - Running pre-action listener: _resource_record_pre_action 01:06:47 INFO - Running main action method: download_and_extract 01:06:47 INFO - mkdir: /builds/slave/test/build/tests 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:06:47 INFO - Downloaded 1361 bytes. 01:06:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:06:47 INFO - Using the following test package requirements: 01:06:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:06:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:06:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'jsshell-linux-x86_64.zip'], 01:06:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:06:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:06:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:06:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:06:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:06:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:51 INFO - Downloaded 24280137 bytes. 01:06:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:53 INFO - Return code: 0 01:06:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:53 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:54 INFO - Downloaded 24280137 bytes. 01:06:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:55 INFO - Return code: 0 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:06:56 INFO - Downloaded 14405240 bytes. 01:06:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:06:56 INFO - Return code: 0 01:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:56 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:06:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:06:58 INFO - Downloaded 60191146 bytes. 01:06:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:58 INFO - mkdir: /builds/slave/test/properties 01:06:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:06:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:06:58 INFO - Contents: 01:06:58 INFO - build_url:https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:59 INFO - Running post-action listener: _resource_record_post_action 01:06:59 INFO - Running post-action listener: set_extra_try_arguments 01:06:59 INFO - ##### 01:06:59 INFO - ##### Finished download-and-extract step (success) 01:06:59 INFO - ##### 01:06:59 INFO - ##### 01:06:59 INFO - ##### Running populate-webroot step. 01:06:59 INFO - ##### 01:06:59 INFO - Running pre-action listener: _resource_record_pre_action 01:06:59 INFO - Running main action method: populate_webroot 01:06:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:06:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:06:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:06:59 INFO - '--tppagecycles', 01:06:59 INFO - '7'], 01:06:59 INFO - 'tests': ['tsvgm']}}, 01:06:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:06:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:06:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:06:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:06:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['damp', 'tps']}, 01:06:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'tests': ['damp', 'tps']}, 01:06:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['dromaeo_dom']}, 01:06:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:06:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['basic_compositor_video']}, 01:06:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:06:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'other-e10s': {'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['a11yr', 01:06:59 INFO - 'ts_paint', 01:06:59 INFO - 'tpaint', 01:06:59 INFO - 'sessionrestore', 01:06:59 INFO - 'sessionrestore_no_auto_restore', 01:06:59 INFO - 'tabpaint']}, 01:06:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['tsvgx', 01:06:59 INFO - 'tsvgr_opacity', 01:06:59 INFO - 'tart', 01:06:59 INFO - 'tscrollx', 01:06:59 INFO - 'cart']}, 01:06:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:06:59 INFO - 'tsvgr_opacity', 01:06:59 INFO - 'tart', 01:06:59 INFO - 'tscrollx', 01:06:59 INFO - 'cart']}, 01:06:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'talos_options': ['--disable-e10s'], 01:06:59 INFO - 'tests': ['tp5o']}, 01:06:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'tests': ['tp5o']}, 01:06:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'talos_options': ['--disable-e10s', 01:06:59 INFO - '--xperf_path', 01:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:59 INFO - 'tests': ['tp5n']}, 01:06:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:59 INFO - 'talos_options': ['--xperf_path', 01:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:59 INFO - 'tests': ['tp5n']}}, 01:06:59 INFO - 'talos.zip': {'path': '', 01:06:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:06:59 INFO - Running post-action listener: _resource_record_post_action 01:06:59 INFO - ##### 01:06:59 INFO - ##### Finished populate-webroot step (success) 01:06:59 INFO - ##### 01:06:59 INFO - ##### 01:06:59 INFO - ##### Running create-virtualenv step. 01:06:59 INFO - ##### 01:06:59 INFO - Running pre-action listener: _resource_record_pre_action 01:06:59 INFO - Running main action method: create_virtualenv 01:06:59 INFO - Creating virtualenv /builds/slave/test/build/venv 01:06:59 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:06:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:06:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:06:59 INFO - Using real prefix '/usr' 01:06:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:06:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:07:01 INFO - Installing pip.................done. 01:07:01 INFO - Return code: 0 01:07:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:07:01 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:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 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:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:01 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:07:01 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:07:01 INFO - Using env: {'DISPLAY': ':0', 01:07:01 INFO - 'HOME': '/home/cltbld', 01:07:01 INFO - 'LANG': 'en_US.UTF-8', 01:07:01 INFO - 'LANGUAGE': 'en_US:en', 01:07:01 INFO - 'LOGNAME': 'cltbld', 01:07:01 INFO - 'MAIL': '/var/mail/cltbld', 01:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:01 INFO - 'MOZ_NO_REMOTE': '1', 01:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:01 INFO - 'NO_EM_RESTART': '1', 01:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:01 INFO - 'PWD': '/builds/slave/test', 01:07:01 INFO - 'SHELL': '/bin/bash', 01:07:01 INFO - 'SHLVL': '1', 01:07:01 INFO - 'TERM': 'linux', 01:07:01 INFO - 'TMOUT': '86400', 01:07:01 INFO - 'USER': 'cltbld', 01:07:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:01 INFO - '_': '/tools/buildbot/bin/python'} 01:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:02 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:07:02 INFO - Cleaning up... 01:07:02 INFO - Return code: 0 01:07:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:07: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:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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', '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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:07: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 psutil>=3.1.1 01:07:02 INFO - Using env: {'DISPLAY': ':0', 01:07:02 INFO - 'HOME': '/home/cltbld', 01:07:02 INFO - 'LANG': 'en_US.UTF-8', 01:07:02 INFO - 'LANGUAGE': 'en_US:en', 01:07:02 INFO - 'LOGNAME': 'cltbld', 01:07:02 INFO - 'MAIL': '/var/mail/cltbld', 01:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:02 INFO - 'MOZ_NO_REMOTE': '1', 01:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:02 INFO - 'NO_EM_RESTART': '1', 01:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:02 INFO - 'PWD': '/builds/slave/test', 01:07:02 INFO - 'SHELL': '/bin/bash', 01:07:02 INFO - 'SHLVL': '1', 01:07:02 INFO - 'TERM': 'linux', 01:07:02 INFO - 'TMOUT': '86400', 01:07:02 INFO - 'USER': 'cltbld', 01:07:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:02 INFO - '_': '/tools/buildbot/bin/python'} 01:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:02 INFO - Downloading/unpacking psutil>=3.1.1 01:07: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:07: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:07: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:07: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:07: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:07: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:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:04 INFO - Installing collected packages: psutil 01:07:04 INFO - Running setup.py install for psutil 01:07:04 INFO - building 'psutil._psutil_linux' extension 01:07:04 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:07:04 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:07:04 INFO - building 'psutil._psutil_posix' extension 01:07:04 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:07:04 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:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:04 INFO - Successfully installed psutil 01:07:04 INFO - Cleaning up... 01:07:04 INFO - Return code: 0 01:07:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:04 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:04 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:07:04 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:07:04 INFO - Using env: {'DISPLAY': ':0', 01:07:04 INFO - 'HOME': '/home/cltbld', 01:07:04 INFO - 'LANG': 'en_US.UTF-8', 01:07:04 INFO - 'LANGUAGE': 'en_US:en', 01:07:04 INFO - 'LOGNAME': 'cltbld', 01:07:04 INFO - 'MAIL': '/var/mail/cltbld', 01:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:04 INFO - 'MOZ_NO_REMOTE': '1', 01:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:04 INFO - 'NO_EM_RESTART': '1', 01:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:04 INFO - 'PWD': '/builds/slave/test', 01:07:04 INFO - 'SHELL': '/bin/bash', 01:07:04 INFO - 'SHLVL': '1', 01:07:04 INFO - 'TERM': 'linux', 01:07:04 INFO - 'TMOUT': '86400', 01:07:04 INFO - 'USER': 'cltbld', 01:07:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:04 INFO - '_': '/tools/buildbot/bin/python'} 01:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:07: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:07: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:07: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:07: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:07: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:07: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:07:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:07:06 INFO - Installing collected packages: mozsystemmonitor 01:07:06 INFO - Running setup.py install for mozsystemmonitor 01:07:07 INFO - Successfully installed mozsystemmonitor 01:07:07 INFO - Cleaning up... 01:07:07 INFO - Return code: 0 01:07:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:07:07 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:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:07 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:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:07 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:07 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:07:07 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:07:07 INFO - Using env: {'DISPLAY': ':0', 01:07:07 INFO - 'HOME': '/home/cltbld', 01:07:07 INFO - 'LANG': 'en_US.UTF-8', 01:07:07 INFO - 'LANGUAGE': 'en_US:en', 01:07:07 INFO - 'LOGNAME': 'cltbld', 01:07:07 INFO - 'MAIL': '/var/mail/cltbld', 01:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:07 INFO - 'MOZ_NO_REMOTE': '1', 01:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:07 INFO - 'NO_EM_RESTART': '1', 01:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:07 INFO - 'PWD': '/builds/slave/test', 01:07:07 INFO - 'SHELL': '/bin/bash', 01:07:07 INFO - 'SHLVL': '1', 01:07:07 INFO - 'TERM': 'linux', 01:07:07 INFO - 'TMOUT': '86400', 01:07:07 INFO - 'USER': 'cltbld', 01:07:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:07 INFO - '_': '/tools/buildbot/bin/python'} 01:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:07 INFO - Downloading/unpacking jsonschema==2.5.1 01:07: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:07: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:07: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:07: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:07: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:07: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:07:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:07:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:07:09 INFO - warning: no files found matching '*.txt' 01:07:09 INFO - no previously-included directories found matching 'build' 01:07:09 INFO - no previously-included directories found matching 'dist' 01:07:09 INFO - no previously-included directories found matching '.git*' 01:07:09 INFO - Installing collected packages: jsonschema, functools32 01:07:09 INFO - Running setup.py install for functools32 01:07:09 INFO - warning: no files found matching '*.txt' 01:07:09 INFO - no previously-included directories found matching 'build' 01:07:09 INFO - no previously-included directories found matching 'dist' 01:07:09 INFO - no previously-included directories found matching '.git*' 01:07:09 INFO - Successfully installed jsonschema functools32 01:07:09 INFO - Cleaning up... 01:07:09 INFO - Return code: 0 01:07:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:07:09 INFO - Using env: {'DISPLAY': ':0', 01:07:09 INFO - 'HOME': '/home/cltbld', 01:07:09 INFO - 'LANG': 'en_US.UTF-8', 01:07:09 INFO - 'LANGUAGE': 'en_US:en', 01:07:09 INFO - 'LOGNAME': 'cltbld', 01:07:09 INFO - 'MAIL': '/var/mail/cltbld', 01:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:09 INFO - 'MOZ_NO_REMOTE': '1', 01:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:09 INFO - 'NO_EM_RESTART': '1', 01:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:09 INFO - 'PWD': '/builds/slave/test', 01:07:09 INFO - 'SHELL': '/bin/bash', 01:07:09 INFO - 'SHLVL': '1', 01:07:09 INFO - 'TERM': 'linux', 01:07:09 INFO - 'TMOUT': '86400', 01:07:09 INFO - 'USER': 'cltbld', 01:07:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:09 INFO - '_': '/tools/buildbot/bin/python'} 01:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:09 INFO - Downloading/unpacking blobuploader==1.2.4 01:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:11 INFO - Downloading blobuploader-1.2.4.tar.gz 01:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:07:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:07:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:12 INFO - Downloading docopt-0.6.1.tar.gz 01:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:07:12 INFO - Installing collected packages: blobuploader, requests, docopt 01:07:12 INFO - Running setup.py install for blobuploader 01:07:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:07:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:07:12 INFO - Running setup.py install for requests 01:07:12 INFO - Running setup.py install for docopt 01:07:13 INFO - Successfully installed blobuploader requests docopt 01:07:13 INFO - Cleaning up... 01:07:13 INFO - Return code: 0 01:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:13 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:13 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:07:13 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:07:13 INFO - Using env: {'DISPLAY': ':0', 01:07:13 INFO - 'HOME': '/home/cltbld', 01:07:13 INFO - 'LANG': 'en_US.UTF-8', 01:07:13 INFO - 'LANGUAGE': 'en_US:en', 01:07:13 INFO - 'LOGNAME': 'cltbld', 01:07:13 INFO - 'MAIL': '/var/mail/cltbld', 01:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:13 INFO - 'MOZ_NO_REMOTE': '1', 01:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:13 INFO - 'NO_EM_RESTART': '1', 01:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:13 INFO - 'PWD': '/builds/slave/test', 01:07:13 INFO - 'SHELL': '/bin/bash', 01:07:13 INFO - 'SHLVL': '1', 01:07:13 INFO - 'TERM': 'linux', 01:07:13 INFO - 'TMOUT': '86400', 01:07:13 INFO - 'USER': 'cltbld', 01:07:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:13 INFO - '_': '/tools/buildbot/bin/python'} 01:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:13 INFO - Running setup.py (path:/tmp/pip-wr5TWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:13 INFO - Running setup.py (path:/tmp/pip-0DFobD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:13 INFO - Running setup.py (path:/tmp/pip-PKWC8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:13 INFO - Running setup.py (path:/tmp/pip-9xGLmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:13 INFO - Running setup.py (path:/tmp/pip-c5CNUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:13 INFO - Running setup.py (path:/tmp/pip-Z4XdCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:13 INFO - Running setup.py (path:/tmp/pip-dAm3JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:13 INFO - Running setup.py (path:/tmp/pip-_WpgyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:13 INFO - Running setup.py (path:/tmp/pip-iPhLea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:13 INFO - Running setup.py (path:/tmp/pip-8WB45Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:14 INFO - Running setup.py (path:/tmp/pip-EuHonB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:14 INFO - Running setup.py (path:/tmp/pip-oyD_TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:14 INFO - Running setup.py (path:/tmp/pip-LhROHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:14 INFO - Running setup.py (path:/tmp/pip-e1696D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:14 INFO - Running setup.py (path:/tmp/pip-P94jhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:14 INFO - Running setup.py (path:/tmp/pip-OSaDvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:14 INFO - Running setup.py (path:/tmp/pip-LhuXe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:07:14 INFO - Running setup.py install for manifestparser 01:07:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:07:14 INFO - Running setup.py install for mozcrash 01:07:14 INFO - Running setup.py install for mozdebug 01:07:14 INFO - Running setup.py install for mozdevice 01:07:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:07:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:07:14 INFO - Running setup.py install for mozfile 01:07:15 INFO - Running setup.py install for mozhttpd 01:07:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for mozinfo 01:07:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for mozInstall 01:07:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for mozleak 01:07:15 INFO - Running setup.py install for mozlog 01:07:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for moznetwork 01:07:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for mozprocess 01:07:15 INFO - Running setup.py install for mozprofile 01:07:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:07:15 INFO - Running setup.py install for mozrunner 01:07:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:07:16 INFO - Running setup.py install for mozscreenshot 01:07:16 INFO - Running setup.py install for moztest 01:07:16 INFO - Running setup.py install for mozversion 01:07:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:07:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:07:16 INFO - Cleaning up... 01:07:16 INFO - Return code: 0 01:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07: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:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:16 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:16 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:07:16 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:07:16 INFO - Using env: {'DISPLAY': ':0', 01:07:16 INFO - 'HOME': '/home/cltbld', 01:07:16 INFO - 'LANG': 'en_US.UTF-8', 01:07:16 INFO - 'LANGUAGE': 'en_US:en', 01:07:16 INFO - 'LOGNAME': 'cltbld', 01:07:16 INFO - 'MAIL': '/var/mail/cltbld', 01:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:16 INFO - 'MOZ_NO_REMOTE': '1', 01:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:16 INFO - 'NO_EM_RESTART': '1', 01:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:16 INFO - 'PWD': '/builds/slave/test', 01:07:16 INFO - 'SHELL': '/bin/bash', 01:07:16 INFO - 'SHLVL': '1', 01:07:16 INFO - 'TERM': 'linux', 01:07:16 INFO - 'TMOUT': '86400', 01:07:16 INFO - 'USER': 'cltbld', 01:07:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:16 INFO - '_': '/tools/buildbot/bin/python'} 01:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:16 INFO - Running setup.py (path:/tmp/pip-1wt4mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:16 INFO - Running setup.py (path:/tmp/pip-jjMua4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:16 INFO - Running setup.py (path:/tmp/pip-fbnBHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:16 INFO - Running setup.py (path:/tmp/pip-uMceqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:16 INFO - Running setup.py (path:/tmp/pip-KOiKcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:16 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:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:16 INFO - Running setup.py (path:/tmp/pip-jqQkja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:17 INFO - Running setup.py (path:/tmp/pip-dSRBZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:17 INFO - Running setup.py (path:/tmp/pip-NvcLjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:17 INFO - Running setup.py (path:/tmp/pip-va33Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:17 INFO - Running setup.py (path:/tmp/pip-i7Yo3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:17 INFO - Running setup.py (path:/tmp/pip-LFWgdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:17 INFO - Running setup.py (path:/tmp/pip-6WlgHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:17 INFO - Running setup.py (path:/tmp/pip-PvaujW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:17 INFO - Running setup.py (path:/tmp/pip-sqwlrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:17 INFO - Running setup.py (path:/tmp/pip-PnVKfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:17 INFO - Running setup.py (path:/tmp/pip-ryVyNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:17 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:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:17 INFO - Running setup.py (path:/tmp/pip-LAp4Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:19 INFO - Downloading blessings-1.6.tar.gz 01:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:07:19 INFO - Installing collected packages: blessings 01:07:19 INFO - Running setup.py install for blessings 01:07:19 INFO - Successfully installed blessings 01:07:19 INFO - Cleaning up... 01:07:19 INFO - Return code: 0 01:07:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:20 INFO - Reading from file tmpfile_stdout 01:07:20 INFO - Current package versions: 01:07:20 INFO - argparse == 1.2.1 01:07:20 INFO - blessings == 1.6 01:07:20 INFO - blobuploader == 1.2.4 01:07:20 INFO - docopt == 0.6.1 01:07:20 INFO - functools32 == 3.2.3-2 01:07:20 INFO - jsonschema == 2.5.1 01:07:20 INFO - manifestparser == 1.1 01:07:20 INFO - mozInstall == 1.12 01:07:20 INFO - mozcrash == 0.17 01:07:20 INFO - mozdebug == 0.1 01:07:20 INFO - mozdevice == 0.48 01:07:20 INFO - mozfile == 1.2 01:07:20 INFO - mozhttpd == 0.7 01:07:20 INFO - mozinfo == 0.9 01:07:20 INFO - mozleak == 0.1 01:07:20 INFO - mozlog == 3.2 01:07:20 INFO - moznetwork == 0.27 01:07:20 INFO - mozprocess == 0.22 01:07:20 INFO - mozprofile == 0.28 01:07:20 INFO - mozrunner == 6.11 01:07:20 INFO - mozscreenshot == 0.1 01:07:20 INFO - mozsystemmonitor == 0.3 01:07:20 INFO - moztest == 0.7 01:07:20 INFO - mozversion == 1.4 01:07:20 INFO - psutil == 3.1.1 01:07:20 INFO - requests == 1.2.3 01:07:20 INFO - wsgiref == 0.1.2 01:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:20 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:07:20 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:07:20 INFO - Using env: {'DISPLAY': ':0', 01:07:20 INFO - 'HOME': '/home/cltbld', 01:07:20 INFO - 'LANG': 'en_US.UTF-8', 01:07:20 INFO - 'LANGUAGE': 'en_US:en', 01:07:20 INFO - 'LOGNAME': 'cltbld', 01:07:20 INFO - 'MAIL': '/var/mail/cltbld', 01:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:20 INFO - 'MOZ_NO_REMOTE': '1', 01:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:20 INFO - 'NO_EM_RESTART': '1', 01:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:20 INFO - 'PWD': '/builds/slave/test', 01:07:20 INFO - 'SHELL': '/bin/bash', 01:07:20 INFO - 'SHLVL': '1', 01:07:20 INFO - 'TERM': 'linux', 01:07:20 INFO - 'TMOUT': '86400', 01:07:20 INFO - 'USER': 'cltbld', 01:07:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:20 INFO - '_': '/tools/buildbot/bin/python'} 01:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 INFO - Cleaning up... 01:07:20 INFO - Return code: 0 01:07:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:20 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:07:20 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:07:20 INFO - Using env: {'DISPLAY': ':0', 01:07:20 INFO - 'HOME': '/home/cltbld', 01:07:20 INFO - 'LANG': 'en_US.UTF-8', 01:07:20 INFO - 'LANGUAGE': 'en_US:en', 01:07:20 INFO - 'LOGNAME': 'cltbld', 01:07:20 INFO - 'MAIL': '/var/mail/cltbld', 01:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:20 INFO - 'MOZ_NO_REMOTE': '1', 01:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:20 INFO - 'NO_EM_RESTART': '1', 01:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:20 INFO - 'PWD': '/builds/slave/test', 01:07:20 INFO - 'SHELL': '/bin/bash', 01:07:20 INFO - 'SHLVL': '1', 01:07:20 INFO - 'TERM': 'linux', 01:07:20 INFO - 'TMOUT': '86400', 01:07:20 INFO - 'USER': 'cltbld', 01:07:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:20 INFO - '_': '/tools/buildbot/bin/python'} 01:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:07:20 INFO - Cleaning up... 01:07:20 INFO - Return code: 0 01:07:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 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 0x7fd612456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, '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': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', '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:07:20 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:07:20 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:07:20 INFO - Using env: {'DISPLAY': ':0', 01:07:20 INFO - 'HOME': '/home/cltbld', 01:07:20 INFO - 'LANG': 'en_US.UTF-8', 01:07:20 INFO - 'LANGUAGE': 'en_US:en', 01:07:20 INFO - 'LOGNAME': 'cltbld', 01:07:20 INFO - 'MAIL': '/var/mail/cltbld', 01:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:20 INFO - 'MOZ_NO_REMOTE': '1', 01:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:20 INFO - 'NO_EM_RESTART': '1', 01:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:20 INFO - 'PWD': '/builds/slave/test', 01:07:20 INFO - 'SHELL': '/bin/bash', 01:07:20 INFO - 'SHLVL': '1', 01:07:20 INFO - 'TERM': 'linux', 01:07:20 INFO - 'TMOUT': '86400', 01:07:20 INFO - 'USER': 'cltbld', 01:07:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:20 INFO - '_': '/tools/buildbot/bin/python'} 01:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:20 INFO - Downloading/unpacking flake8 01:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:20 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:07:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:07:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:07:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:07:23 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:07:23 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:07:23 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:07:23 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:07:23 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:07:23 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:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:23 INFO - no previously-included directories found matching 'docs/_build' 01:07:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:07:23 INFO - Running setup.py install for pep8 01:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:23 INFO - no previously-included directories found matching 'docs/_build' 01:07:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:07:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:07:23 INFO - Cleaning up... 01:07:23 INFO - Return code: 0 01:07:23 INFO - Running post-action listener: _resource_record_post_action 01:07:23 INFO - Running post-action listener: _start_resource_monitoring 01:07:23 INFO - Starting resource monitoring. 01:07:23 INFO - ##### 01:07:23 INFO - ##### Finished create-virtualenv step (success) 01:07:23 INFO - ##### 01:07:23 INFO - ##### 01:07:23 INFO - ##### Running install step. 01:07:23 INFO - ##### 01:07:23 INFO - Running pre-action listener: _resource_record_pre_action 01:07:23 INFO - Running main action method: install 01:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:23 INFO - Reading from file tmpfile_stdout 01:07:23 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:24 INFO - Reading from file tmpfile_stdout 01:07:24 INFO - Output received: 01:07:24 INFO - Usage: mozinstall [options] installer 01:07:24 INFO - Options: 01:07:24 INFO - -h, --help show this help message and exit 01:07:24 INFO - -d DEST, --destination=DEST 01:07:24 INFO - Directory to install application into. [default: 01:07:24 INFO - "/builds/slave/test"] 01:07:24 INFO - --app=APP Application being installed. [default: firefox] 01:07:24 INFO - mkdir: /builds/slave/test/build/application 01:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:07:46 INFO - Reading from file tmpfile_stdout 01:07:46 INFO - Output received: 01:07:46 INFO - /builds/slave/test/build/application/firefox/firefox 01:07:48 INFO - Running post-action listener: _resource_record_post_action 01:07:48 INFO - ##### 01:07:48 INFO - ##### Finished install step (success) 01:07:48 INFO - ##### 01:07:48 INFO - ##### 01:07:48 INFO - ##### Running run-tests step. 01:07:48 INFO - ##### 01:07:48 INFO - Running pre-action listener: _resource_record_pre_action 01:07:48 INFO - Running main action method: run_tests 01:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:07:48 INFO - Python 2.7.3 01:07:48 INFO - Return code: 0 01:07:48 INFO - grabbing minidump binary from tooltool 01:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:48 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 0x1cdc6f0>, '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 0x1cdd5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cddaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:07:48 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:07:48 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:07:48 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:07:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:07:49 INFO - Return code: 0 01:07:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:07:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:07:50 INFO - Return code: 0 01:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:07:50 INFO - Using env: {'DISPLAY': ':0', 01:07:50 INFO - 'HOME': '/home/cltbld', 01:07:50 INFO - 'LANG': 'en_US.UTF-8', 01:07:50 INFO - 'LANGUAGE': 'en_US:en', 01:07:50 INFO - 'LOGNAME': 'cltbld', 01:07:50 INFO - 'MAIL': '/var/mail/cltbld', 01:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:50 INFO - 'MOZ_NO_REMOTE': '1', 01:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:50 INFO - 'NO_EM_RESTART': '1', 01:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:50 INFO - 'PWD': '/builds/slave/test', 01:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:07:50 INFO - 'SHELL': '/bin/bash', 01:07:50 INFO - 'SHLVL': '1', 01:07:50 INFO - 'TERM': 'linux', 01:07:50 INFO - 'TMOUT': '86400', 01:07:50 INFO - 'USER': 'cltbld', 01:07:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292', 01:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:50 INFO - '_': '/tools/buildbot/bin/python'} 01:07:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:07:50 INFO - mozversion application_buildid: 20160626223041 01:07:50 INFO - mozversion application_changeset: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 01:07:50 INFO - mozversion application_display_name: Nightly 01:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:07:50 INFO - mozversion application_name: Firefox 01:07:50 INFO - mozversion application_remotingname: firefox 01:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:50 INFO - mozversion application_vendor: Mozilla 01:07:50 INFO - mozversion application_version: 50.0a1 01:07:50 INFO - mozversion platform_buildid: 20160626223041 01:07:50 INFO - mozversion platform_changeset: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 01:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:50 INFO - mozversion platform_version: 50.0a1 01:07:50 INFO - using testdate: 1467014870 01:07:50 INFO - actual date: 1467014870 01:07:50 INFO - starting webserver on 'localhost:59081' 01:07:50 INFO - SUITE-START | Running 2 tests 01:07:50 INFO - TEST-START | dromaeo_css 01:07:50 INFO - operating with platform_type : linux_ 01:07:50 INFO - Initialising browser for dromaeo_css test... 01:07:50 INFO - TEST-INFO | started process 26266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuMbElv/profile http://localhost:59081/getInfo.html) 01:07:56 INFO - PROCESS | 26266 | __metrics Screen width/height:1600/1200 01:07:56 INFO - PROCESS | 26266 | colorDepth:24 01:07:56 INFO - PROCESS | 26266 | Browser inner width/height: 1024/697 01:07:56 INFO - PROCESS | 26266 | __metrics 01:07:58 INFO - PROCESS | 26266 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:07:59 INFO - PROCESS | 26266 | console.error: PushService: 01:07:59 INFO - PROCESS | 26266 | stateChangeProcessEnqueue: Error transitioning state 01:07:59 INFO - PROCESS | 26266 | UnknownError 01:07:59 INFO - TEST-INFO | 26266: exit 0 01:07:59 INFO - Browser initialized. 01:07:59 INFO - Running cycle 1/1 for dromaeo_css test... 01:07:59 INFO - TEST-INFO | started process 26351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuMbElv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:11 INFO - PROCESS | 26351 | RSS: Main: 174088192 01:08:11 INFO - PROCESS | 26351 | 01:09:02 INFO - PROCESS | 26351 | 1467014942530 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:11:12 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59081/tests/dromaeo/cssquery-ext.html) 01:11:13 INFO - PROCESS | 26351 | RSS: Main: 265543680 01:11:13 INFO - PROCESS | 26351 | 01:14:15 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-ext.html (next: http://localhost:59081/tests/dromaeo/cssquery-jquery.html) 01:14:16 INFO - PROCESS | 26351 | RSS: Main: 260165632 01:14:16 INFO - PROCESS | 26351 | 01:17:18 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59081/tests/dromaeo/cssquery-mootools.html) 01:17:19 INFO - PROCESS | 26351 | RSS: Main: 268562432 01:17:19 INFO - PROCESS | 26351 | 01:20:21 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59081/tests/dromaeo/cssquery-prototype.html) 01:20:21 INFO - PROCESS | 26351 | RSS: Main: 259391488 01:20:21 INFO - PROCESS | 26351 | 01:23:24 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59081/tests/dromaeo/cssquery-yui.html) 01:23:25 INFO - PROCESS | 26351 | RSS: Main: 240812032 01:23:25 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:59081/tests/dromaeo/cssquery-yui.html (next: http://localhost:59081/tests/dromaeo/cssquery-dojo.html) 01:26:27 INFO - PROCESS | 26351 | RSS: Main: 314130432 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | __start_tp_report 01:26:27 INFO - PROCESS | 26351 | _x_x_mozilla_page_load 01:26:27 INFO - PROCESS | 26351 | _x_x_mozilla_page_load_details 01:26:27 INFO - PROCESS | 26351 | |i|pagename|runs| 01:26:27 INFO - PROCESS | 26351 | |0;dojo.html;3118.2983828638557;3155.7317628001624;3156.7948083374563;3184.4586420308547;3213.052149615863;5283.418823929364;5353.9196912046355;5457.672539647624;5542.362628297747;5561.332640083186;5402.810901618444;5405.216243644669;5411.729413529328;5459.481349271823;5473.28847249857;4859.416869975599;4938.827141050064;4945.406551213841;4961.280614310923;5094.974525127388;4995.350604421438;5015.949840501603;5034.270030845525;5039.420466646346;5088.745562721868;4807.30294107356;4866.440359358684;4895.241237608177;4914.287428322891;4950.529699678525;4944.90110197794;4946.356973593446;4949.925751113737;4963.578095861856;5001.299818025479;4947.703137811707;4972.254161875748;4980.726060066695;4986.62600304975;5015.498450154992;5322.893542129135;5356.35723713153;5383.623146379755;5398;5562.4993750562235;5782.710864456761;5835.0372188588835;5842.415758424166;5849.181114643953;5850.385709500526;5845.357010728816;5899.911501327483;5912.586118971673;5913.0539113742025;5921.822345329647;5229.712365819878;5289.841304760864;5369.677819330853;5372.785088596491;5440.401555828856;5920.052791553331;5923.526117910643;5927;5929.199558059693;5934.554908381889;5559.944400555943;5652.123920792284;5656.43435656431;5693.857653558694;5695.5443564514735;5762.9135562966585;5819.272590926134;5827.679477628772;5842.211301474332;5849.034909239927;5823.737931793079;5825.359210486843;5829.7376618052285;5835.4748072673665;5836.2412886325355;5660.745266463019;5758.7696492140685;5774.797882074107;5834.095715164156;5840.503557197686;4432.3794668746405;4448.399466072104;4448.844290449819;4489.820407183742;4493.752843593568;3926.823292951824;3943.881683549498;3952.5256969163884;3959.9010024749036;3981.820818063194;5335.9466405336225;5357.330333708286;5371.194320851903;5519.116941289374;5527.115661494222;5689.943100569024;5725.541956643458;5748.166515855178;5748.281464816898;5798.1302804579655;5251.264822924793;5302.681839089667;5309.309789727311;5339.14573668219;5391.919121213185;4679.789409476582;4773;4803.543663351976;4842.491538388418;4846.878828029327;5938.821835345033;5958.851028724316;5970.552208584373;5978.163057172;6009;5738.741756621045;5751.798687045934;5752.223449834386;5753.05074662676;5763.394843541536;5894.970525147347;5914.940850591611;5919.200907877382;5958.433948774859;5982.760689572368;5697.059985102412;5720.11338242573;5722.570807189394;5723.341815691082;5724.169995350568;5723.914141287801;5780.884382312414;5783.16144159103;5787.074068149076;5791.189233507228;5593.916091258553;5614.214010038516;5629.971850140723;5659.603827732019;5683.431656834284;5628.409017053151;5637.57718171147;5639.125935480007;5642.605017648725;5678.829635110953;5449.618526703092;5532.0595498766115;5572.164175373727;5585.162225666182;5592;5681.460261275172;5711.143328500758;5744.281964754406;5807.303123625192;5810.6513609183585;5592.356878958972;5608.915866262091;5612.5509959202345;5613.607047506635;5615.410381910004 01:26:27 INFO - PROCESS | 26351 | |1;ext.html;584.573261519091;609.3997412548639;619.0590302739838;634;634.0330995232268;32753;36519.08702282441;42996.785016074915;44024.05675233842;44117.77941110298;45974;46299.76850115753;46378.30432543506;46379.536204637945;46406;8934.776630584254;9090.13643703847;9093.18161365477;9093.818123637524;9095;8840.778980525474;8948.463092214455;8952.14954579314;8966.0585638508;8974.551272436385;8989.730308090768;9055.275577953747;9057.773555661095;9059.864102038475;9060.909390906072;9038.593263303168;9108.271338292921;9109.362344635878;9113.589888455002;9118.726438206864;9000.099990001014;9000.144986226298;9051.23064539515;9052.049534798816;9053.909460905372;42835;43082.78458607687;43187.78406107981;43231.35152972708;43434.34848477275;3442.5008373785913;3548.929021419583;3568.536090308269;3721.2371463849845;3970.6426421621904;31245.843770781226;34325.313493729984;34327;34421.6557834421;34444.13889652754;4339.1104823511105;4497.806190315484;4587.564181402761;4594.333821595883;4696.272077827942;380826;389181;389811;391962;392553;67184.6640766793;68049;68116;68176.6591167041;68239;47887.521124788305;47943.28085078727;47959.520404795505;47979.760101199274;48109;16603.252853621616;17694.29222831098;17957.64084718298;17969;17987.1006449677;12568.74862502763;12992.285424301564;12995;13481.191128532319;13747.518836840864;14429.405373551983;19056.809431905782;19361.419157425298;19788;19911.701324480146;7340.96329518349;7408.9629551851895;7718.3053525183;7724.6523906424345;7837.686492540349;942.8114377124602;1071.7856428714288;1122.2763904089081;1127.7518945832069;1142.5715356741223;33337;33435.331293373994;33495.330093398;33558.225877280805;33583.734424902024;1110.1008183371496;1111.5387114347616;1142.8914253145938;1174.2015429508017;1238.8203710461933;16355.34578616842;17175.398861040052;17269.481915542554;17312;17388.826111738974;581234;584816;585410;585437;587033;61750.691246544375;62121.689391552754;62213;62241;62292;1275.993620031894;1330.9267990260628;1344.2405041151717;1369.383777300219;1386.9805692815974;31094;34411.13972150616;34603.826980864935;34604.82697586496;34829;54508;55626;55645;55671;55673.721631391585;503035;516253;516886;516929;517922;39350.212995739355;45250.32124518201;45637.77181114073;45873.77063114663;50541.241881372545;49823.50176498334;50780.746096269286;51180.48819511757;51303.74348128385;51421.1718355494;42875.78562107169;43098;43842.342364863915;44535;44831.77584112059;41940;41970.790146049076;42318;42405.5759442414;43043;42920.35619465648;42989.570104299804;43460;45674.54325456703;46801.531984679714;36346.63653363432;39447.60552394554;39505.604943950195;39616;40058.19883602254;28294.71705283003;28817.711822882342;29106.7089329104;29293.414131717673;29623.703762962094 01:26:27 INFO - PROCESS | 26351 | |2;jquery.html;370.18743857233386;376.7080512602734;381.6164754421807;392.6230818414322;403.73555321264564;17079.57301067474;18837.434876953695;19056.42830715079;19188.616227675437;19333.90333048333;19048.809511904878;19406.126724297406;19762.505937351572;19767.802321976775;19813.108410121542;5604.3835178130375;5683.976884160849;5770.653760774346;5860.472557469827;5863.237779088712;5707.1153971134545;5731.197632331477;5743.368229494752;5756.884862302752;5772.82681519553;5465.398806131342;5706.629069110515;5721.485066344028;5746.626469279504;5755.913661295084;5694.544436445095;5704.971475142639;5726.055200891848;5737.627054241482;5754.136879468071;5099.46455622158;5113.51421614946;6557.704903279317;7042.6830792614455;7044.64776761165;25462.490750184894;25861.870690646614;26292.21123366302;26401.73598264012;26576.06983755559;2294.770522947692;2396.6165413533927;2425.514897020585;2500.624906264057;2523.775968655201;14959.700805983928;15981.360745570164;16156.27296771648;16236.675266494722;16959.406420775213;2084.812366886972;2109.694094356325;2155.5796619659172;2202.064122747826;2224.5439684864564;97849;101722;102294.48852755688;103219.48390258076;104725.47637261765;17642.735358969625;17925.551861203574;18432.447026589223;19294.71057934132;19835;32287.838560807046;32434;32572.511412328833;32702.182445439055;32702.672973270437;10203.744906377251;10372.688819335432;10541.606349523348;10558.788824223473;10575;8600.483970961763;8672;8749.781255468537;8762.211400973943;8770.429922055173;8896.644134234559;9105.681301154427;9134.269258459308;9145.222656074175;9291.535423228812;3207.2302647364463;3347.5480810090326;3402.302527981758;3488.581370235588;3573.6069032406413;873.4671850171391;889.7686601483531;1032.5147180825;1067.3595842494597;1083.664064140119;18865.90567047156;19599.216031358872;19705.901470492558;19774.40676779699;20070.39788806309;1003.8694969654044;1018.7096677446892;1033.503918119307;1040.147079394889;1057.9523921423402;10179.338343007681;11022.50398732059;11029.724256893642;11054.944725276482;11154.944225278983;466787;473560;474935;476329;479098;96642;98909.99999999856;99441;99920;100199;998.6953979036464;1005.9748506287401;1008.8688470498935;1018.0582960761266;1026.7381817636456;16943.15284235808;17169.656606868044;17538.82461175372;17571.209295581986;17779.199936002653;41216.79391603023;41549.792251038554;41697;42781.572184279;45668.54331456643;58208.4179158203;59022.704886475294;60073.692262313576;60818.391816081275;60940.39059609347;8220.219079187467;8229.95885020571;8234;8288.171182881664;8436;9007.279417646703;13231.3384330785;14303.426623071246;14349.928250358682;14613.050151740528;12262.938685306517;12416.75166496683;12503.187292825936;12585.748285034431;12675.30285834288;11942.283462991902;12108.21296615717;12430.067744918986;12593.559225427432;12689.175203612105;12563.246205227715;12642.431090600761;12773.425195866394;12776.936115319364;12843.743125137258;8520.914790852261;8605.612747426256;8630;8786.604602792762;8817.515036673045;11809.468573914022;12140.75718485643;12333.383330833243;12410.069244806857;12488.375581221084 01:26:27 INFO - PROCESS | 26351 | |3;mootools.html;1336.1114858619019;1503.804505414296;1509.0492989416668;1672.172274724011;1822.7903791064023;8494.745157645273;8880.733577992654;8900.24347930426;9158.679446219367;9176.4035337703;8575.528345940971;8799.252063574588;8799.252063574604;8818.86771698425;8823.691170809023;2004.1782869023702;2233.3858188998074;2321.5821152192684;2323.616603260464;2351.0360752091647;2313.363824948136;2316.247219653611;2317.9884100579475;2320.454693147109;2321.5472982768365;2253.6281513550243;2307.976920230793;2322;2323.628219484874;2323.744388117306;1922.692369220925;2136.2736669532433;2197;2203.2398822406244;2251.2570851619007;2252.831037672181;2252.8986195621237;2278.168468508982;2278.2140161644206;2278.646809744492;9191;9224.723258302261;9247.21398681113;9255.259579233712;9265.722028339093;5121.129408000649;5270.762815673265;5271.578273738091;5272.209168624737;5278.947210527884;3356.1777364545596;3404;3452.2405070884365;3500.7899526028264;3509.999650099735;1176.1707995862896;1181.8699943006263;1184.4373922386796;1198.5445530698366;2177.4665207024223;12132.150749447543;12562.371881405894;12573.308468034254;12631.810522842165;12641.747165056648;4308.138372325548;4319.654427645781;4354.738715677069;4429.933550996738;4438.289873620205;10029.79940401188;10034.24743144267;10035.046670566284;10142.746431339276;10148.54331555067;5211.1662134059125;5222.503862133091;5224.111900976843;5226.817061402832;5227.947720522822;4191;4767;4900.240462728283;4917.164082106051;4998.2502624606595;3716.4239542870896;3793.867214647474;3830.3871380578976;3873.1285460771664;3925.2738243425056;1102.5534658463334;1106.9944650276698;1113.0205419231186;1116.8045592021365;1120.4117838135044;953.1850268020881;972.8103019911049;998.7103739915489;1005.3364779245662;1010.8260359481792;6090.939090609126;6113.205283313141;6168.722407491674;6408.2630497492455;6414.294427612959;410.25333892316297;410.50534106401716;422.6449782182981;423.3924318602815;425.8658522565382;4331.610155085994;4342.34864770287;4411.713238639478;4426.26966550522;4446.155230506258;10870.402127883042;11042.834357484644;11176.552937882394;11228.719282018015;11230.213885028134;10708.411037393018;11042.171837112248;11052;11079.50142243601;11091.33451992883;8237.588120594066;8549.187827156411;8627.741167764978;8644.222020018104;8645.573480375793;6078.665673388006;6319.905201422074;6391.137196478602;6514.2834288229205;6517.674116294261;10080.647177348757;10712.8928710715;10720.35677859331;10720.35677859331;10722.410267435365;10424.739381515523;10815.837762433726;10854.728631784268;10930.726731831768;10957.452127393757;7226.168990566152;7944.721934732257;8179;8263.504189748393;8440.493570385797;8999.910000900169;9034.593443294936;9081.046490118442;9122.179003889682;9138.954305228432;7666.846663066819;7889.842203156019;7934.682612695427;7999.280064794197;8020.15788342239;7734.149243583314;8005.439619226599;8027.678892844455;8094.878576821235;8136.1863813618165;7292.635368231673;7305.744298949511;7386.482946193715;7410.96294518524;7414.8146296340865;5190.766415511386;5208.609354298367;5323.361196656426;5343.118385466354;5448.972755136199;5234.712090835041;5520.1443776214755;5527.700990267364;5595.384507704231;5723.3418156912485 01:26:27 INFO - PROCESS | 26351 | |4;prototype.html;321.9935601287974;323.5179582422191;326.2496258605207;327.2522286575175;328.99342013159753;5334.359876814778;5343.786248550063;5358.598105142115;5406.135018397063;5413.539849112825;5208.85405210854;5222.556082732972;5267.920981185285;5277.498637629428;5316.946830531693;3878.747881387708;3963.4054891766177;4088.425956006944;4118.846722917588;4137.855175068873;4076.653484453825;4092.6725861930972;4095.6313931746135;4106.322456794625;4117.341225403936;3911.2373087247997;4089.5297040840387;4099.323611604082;4106.630403263705;4107.260693075245;3951.3677811550156;4068.8403804915456;4074.714769966118;4075.3683179107284;4108.337037462472;3603.56757189139;3607.494950706903;3609.151849315409;3619.6380361963857;3626.1478552540134;5065.265536497224;5118.232265160219;5181.145111056671;5183.507566781187;5188.22176673502;4435.889102772424;4659.394278743742;4669.486356500782;4669.789859456333;4680.478844375558;5471.644343117685;5507.889842203173;5510;5514.228008078872;5528.723563821833;3958.8218530166214;3981.6615587675083;3991.0044977511243;3996.48045754053;4018.2566225248424;5577.776888924438;5581.6930068846195;5621.4659607337235;5703.999999999958;5721.141828725683;3950.585188555218;3959.1883663848844;3983.8008099594904;3986.123052928351;3996.5204175498543;4020.718549701551;4048.149888523443;4056.1887622475624;4077.857274995361;4089.488813898263;4516.39667917891;4652.488226295105;4669.556392142741;4688.249880019249;4700.318453824177;5473.863153421116;5511.696856672921;5535.612507124462;5541.224228607998;5544.362398324163;1405.8172437583048;1428.8928330375263;1430.790981620529;1434.0965191929017;1437.5552569667418;917.9219766319804;927.6057675488025;946.2288235088381;960.865478832964;976.9302613638055;5224.373075230997;5239.554637855825;5245.291885595472;5246.475352464723;5263.315768950012;5581.6371935824045;5581.888362232733;5584.944150558524;5600.803971860965;5612.971935140298;5133.743312834344;5210.505002024802;5216.9739151304;5247.134222853263;5288.603354748409;2933.882644694231;2971.5542668599883;2973.925651858721;2984.2688541307084;2988.8804447822276;5504.587155963319;5767.134929760486;5783.94216057834;5789.421057894261;5831.620944638585;5630.296212973379;5651.237082993825;5661.745221464962;5662.8301150965535;5696.202531645573;5697.800576979786;5721.485066344049;5733.77064917407;5759.22250496186;5782.3639399666845;5313.388960269618;5518.944810551843;5561.360443549043;5592.384837667934;5592.832215033555;5438.728063596884;5489.682476205761;5490.258815059916;5496.6701997880255;5505.779768809202;5679;5734.139879018181;5734.595024219093;5741.971290143522;5783.797567085132;3961.6038396161307;4052.675785937177;4085.20338533983;4107.568705285902;4110.116324990141;5562.833115006394;5568.49883510486;5621.80323688669;5622.971885140548;5650.63270887391;5290.206469029677;5461.15352120422;5472.644278121909;5488.518100113027;5521.365043020104;5352.384475785335;5355.2234925934745;5401.918971215357;5472.72636368188;5527.972360138174;5161.458046905171;5242.816501422432;5281.366236051698;5305.867353316198;5328.014317351302;5477.972610136924;5513.696746678811;5531.944680553143;5548.696056426817;5569.4709002646305;5384.488473595002;5388.865278368072;5391.487808658171;5444.401115877171;5463.541406367231 01:26:27 INFO - PROCESS | 26351 | |5;yui.html;700.9299070092989;722.8626560953415;774.5894675821817;807.4590024683463;844.3203221406767;15392.384304627802;15901.363945442183;15927.283272252747;15944.123073230967;15956.601084972881;14509;15724.842751572482;15751.527454176394;15790.842091579081;15808.920955395235;687.6355531568277;825.7646570727344;836.017679226909;844.1980118887051;844.4553263145268;804.9235322644339;837.5728378526965;839.7438781171741;840.277361469136;840.7057529864529;864.9567521623893;865.5412631305418;867.8915135608049;868.0364795077459;868.4962721621445;718.1812733483832;739.663453128825;864.446754077391;864.9827003459927;865.2558799432483;543.2503145659005;605.461139585769;625.5777350288582;625.7090452939404;627.244170774216;14992.400303987828;14997.850021499755;15009.474668386554;15462.61343466411;15475;10908.61819836302;11435.199536032482;11637.650870473899;11862.22895511789;11996.64010079699;12322.199057061353;12444.440000200013;12500.49998000079;12562.81155782664;12599.37003149848;4633.675642705012;4677.134730074947;4727.314539391769;4729.55069268419;4935;76637.61681191614;76906.23093769046;78022.21977780206;80597;80716.59641701754;11298.661040168809;11365.886341136647;11457.369844658457;11498.195126341243;11851.644450666494;21717.67423488649;21823.12707491714;21849.78150218509;21863.672044919338;22168.556628867656;8858.379913406;8927.24118449926;8943.418677785923;8992.370534062684;9061.818763624691;4590.495045544987;4594.678372513892;4650.441946966385;4685.109829132454;4707.741074240881;3490.3717330880686;3586.8565257389932;3590.4434812604086;3606.945895811565;3607.0801945503727;568.8720037991419;571.562754492805;578.5574035862569;584.0742423259097;585.0463744097094;684.4079870911626;693.0967563071761;696.4150113904344;704.327367364166;706.4877963476439;9232.169104780467;9514.346912180905;9711.951440242894;9879.851802222973;9974.750631234132;640.3916279534461;668.4552090046597;670.686132841698;674.8953912143626;676.7868121541699;4432.086198763662;4478.776061196927;4638.744869032235;4757.5718185363485;4799.784009719571;116341;122670.38664806618;123238;125598;125849;105704.47147764366;108914;109372;109544.4522777381;109792;90512;92822.53588732013;93359;93546.53226733823;94568;8862.158094980967;8927.687530936386;9027.503487307999;9082.59128339213;9254;53281.46718532765;54617.453825461234;55144.44855551393;55153;55683.44316556783;69363.30636693568;79655.60172199101;81619;81911.77132343139;84301.99131082537;11617.186796924134;11671.299722016705;11676;11700.47347869331;11936.522539098687;13165.736685266433;13381.39783709755;13410.396532156272;13460.528881489492;13469.663258418226;12282.570110046105;12469.002479801775;12587.622371328875;12693.365331733561;12693.746125077261;12047.578334758242;12255.75488490243;12263.38683065861;12365.07261955339;12454.25274483534;11390.544378224778;11509.769804603693;11897.345645989208;11908.940455297668;12272.44773985155;10179.236557258087;10212.438315892698;10340.793184136426;10354;10362.585496580354;9153.405028673114;10058.195344372287;10058.547365368722;10193.23550733683;10209.183265338903 01:26:27 INFO - PROCESS | 26351 | __end_tp_report 01:26:27 INFO - PROCESS | 26351 | __start_cc_report 01:26:27 INFO - PROCESS | 26351 | _x_x_mozilla_cycle_collect,820 01:26:27 INFO - PROCESS | 26351 | __end_cc_report 01:26:27 INFO - PROCESS | 26351 | __startTimestamp1467015987884__endTimestamp 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | ------- Summary: start ------- 01:26:27 INFO - PROCESS | 26351 | Number of tests: 6 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#0] dojo.html Cycles:165 Average:5374.55 Median:5593.92 stddev:605.63 (10.8%) stddev-sans-first:581.05 01:26:27 INFO - PROCESS | 26351 | Values: 3118.3 3155.7 3156.8 3184.5 3213.1 5283.4 5353.9 5457.7 5542.4 5561.3 5402.8 5405.2 5411.7 5459.5 5473.3 4859.4 4938.8 4945.4 4961.3 5095.0 4995.4 5015.9 5034.3 5039.4 5088.7 4807.3 4866.4 4895.2 4914.3 4950.5 4944.9 4946.4 4949.9 4963.6 5001.3 4947.7 4972.3 4980.7 4986.6 5015.5 5322.9 5356.4 5383.6 5398.0 5562.5 5782.7 5835.0 5842.4 5849.2 5850.4 5845.4 5899.9 5912.6 5913.1 5921.8 5229.7 5289.8 5369.7 5372.8 5440.4 5920.1 5923.5 5927.0 5929.2 5934.6 5559.9 5652.1 5656.4 5693.9 5695.5 5762.9 5819.3 5827.7 5842.2 5849.0 5823.7 5825.4 5829.7 5835.5 5836.2 5660.7 5758.8 5774.8 5834.1 5840.5 4432.4 4448.4 4448.8 4489.8 4493.8 3926.8 3943.9 3952.5 3959.9 3981.8 5335.9 5357.3 5371.2 5519.1 5527.1 5689.9 5725.5 5748.2 5748.3 5798.1 5251.3 5302.7 5309.3 5339.1 5391.9 4679.8 4773.0 4803.5 4842.5 4846.9 5938.8 5958.9 5970.6 5978.2 6009.0 5738.7 5751.8 5752.2 5753.1 5763.4 5895.0 5914.9 5919.2 5958.4 5982.8 5697.1 5720.1 5722.6 5723.3 5724.2 5723.9 5780.9 5783.2 5787.1 5791.2 5593.9 5614.2 5630.0 5659.6 5683.4 5628.4 5637.6 5639.1 5642.6 5678.8 5449.6 5532.1 5572.2 5585.2 5592.0 5681.5 5711.1 5744.3 5807.3 5810.7 5592.4 5608.9 5612.6 5613.6 5615.4 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#1] ext.html Cycles:180 Average:66065.91 Median:44070.92 stddev:133470.91 (302.9%) stddev-sans-first:133754.78 01:26:27 INFO - PROCESS | 26351 | Values: 584.6 609.4 619.1 634.0 634.0 32753.0 36519.1 42996.8 44024.1 44117.8 45974.0 46299.8 46378.3 46379.5 46406.0 8934.8 9090.1 9093.2 9093.8 9095.0 8840.8 8948.5 8952.1 8966.1 8974.6 8989.7 9055.3 9057.8 9059.9 9060.9 9038.6 9108.3 9109.4 9113.6 9118.7 9000.1 9000.1 9051.2 9052.0 9053.9 42835.0 43082.8 43187.8 43231.4 43434.3 3442.5 3548.9 3568.5 3721.2 3970.6 31245.8 34325.3 34327.0 34421.7 34444.1 4339.1 4497.8 4587.6 4594.3 4696.3 380826.0 389181.0 389811.0 391962.0 392553.0 67184.7 68049.0 68116.0 68176.7 68239.0 47887.5 47943.3 47959.5 47979.8 48109.0 16603.3 17694.3 17957.6 17969.0 17987.1 12568.7 12992.3 12995.0 13481.2 13747.5 14429.4 19056.8 19361.4 19788.0 19911.7 7341.0 7409.0 7718.3 7724.7 7837.7 942.8 1071.8 1122.3 1127.8 1142.6 33337.0 33435.3 33495.3 33558.2 33583.7 1110.1 1111.5 1142.9 1174.2 1238.8 16355.3 17175.4 17269.5 17312.0 17388.8 581234.0 584816.0 585410.0 585437.0 587033.0 61750.7 62121.7 62213.0 62241.0 62292.0 1276.0 1330.9 1344.2 1369.4 1387.0 31094.0 34411.1 34603.8 34604.8 34829.0 54508.0 55626.0 55645.0 55671.0 55673.7 503035.0 516253.0 516886.0 516929.0 517922.0 39350.2 45250.3 45637.8 45873.8 50541.2 49823.5 50780.7 51180.5 51303.7 51421.2 42875.8 43098.0 43842.3 44535.0 44831.8 41940.0 41970.8 42318.0 42405.6 43043.0 42920.4 42989.6 43460.0 45674.5 46801.5 36346.6 39447.6 39505.6 39616.0 40058.2 28294.7 28817.7 29106.7 29293.4 29623.7 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#2] jquery.html Cycles:180 Average:30711.72 Median:13993.13 stddev:78705.45 (562.5%) stddev-sans-first:78893.27 01:26:27 INFO - PROCESS | 26351 | Values: 370.2 376.7 381.6 392.6 403.7 17079.6 18837.4 19056.4 19188.6 19333.9 19048.8 19406.1 19762.5 19767.8 19813.1 5604.4 5684.0 5770.7 5860.5 5863.2 5707.1 5731.2 5743.4 5756.9 5772.8 5465.4 5706.6 5721.5 5746.6 5755.9 5694.5 5705.0 5726.1 5737.6 5754.1 5099.5 5113.5 6557.7 7042.7 7044.6 25462.5 25861.9 26292.2 26401.7 26576.1 2294.8 2396.6 2425.5 2500.6 2523.8 14959.7 15981.4 16156.3 16236.7 16959.4 2084.8 2109.7 2155.6 2202.1 2224.5 97849.0 101722.0 102294.5 103219.5 104725.5 17642.7 17925.6 18432.4 19294.7 19835.0 32287.8 32434.0 32572.5 32702.2 32702.7 10203.7 10372.7 10541.6 10558.8 10575.0 8600.5 8672.0 8749.8 8762.2 8770.4 8896.6 9105.7 9134.3 9145.2 9291.5 3207.2 3347.5 3402.3 3488.6 3573.6 873.5 889.8 1032.5 1067.4 1083.7 18865.9 19599.2 19705.9 19774.4 20070.4 1003.9 1018.7 1033.5 1040.1 1058.0 10179.3 11022.5 11029.7 11054.9 11154.9 466787.0 473560.0 474935.0 476329.0 479098.0 96642.0 98910.0 99441.0 99920.0 100199.0 998.7 1006.0 1008.9 1018.1 1026.7 16943.2 17169.7 17538.8 17571.2 17779.2 41216.8 41549.8 41697.0 42781.6 45668.5 58208.4 59022.7 60073.7 60818.4 60940.4 8220.2 8230.0 8234.0 8288.2 8436.0 9007.3 13231.3 14303.4 14349.9 14613.1 12262.9 12416.8 12503.2 12585.7 12675.3 11942.3 12108.2 12430.1 12593.6 12689.2 12563.2 12642.4 12773.4 12776.9 12843.7 8520.9 8605.6 8630.0 8786.6 8817.5 11809.5 12140.8 12333.4 12410.1 12488.4 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#3] mootools.html Cycles:180 Average:5925.70 Median:4336.98 stddev:3434.33 (79.2%) stddev-sans-first:3426.64 01:26:27 INFO - PROCESS | 26351 | Values: 1336.1 1503.8 1509.0 1672.2 1822.8 8494.7 8880.7 8900.2 9158.7 9176.4 8575.5 8799.3 8799.3 8818.9 8823.7 2004.2 2233.4 2321.6 2323.6 2351.0 2313.4 2316.2 2318.0 2320.5 2321.5 2253.6 2308.0 2322.0 2323.6 2323.7 1922.7 2136.3 2197.0 2203.2 2251.3 2252.8 2252.9 2278.2 2278.2 2278.6 9191.0 9224.7 9247.2 9255.3 9265.7 5121.1 5270.8 5271.6 5272.2 5278.9 3356.2 3404.0 3452.2 3500.8 3510.0 1176.2 1181.9 1184.4 1198.5 2177.5 12132.2 12562.4 12573.3 12631.8 12641.7 4308.1 4319.7 4354.7 4429.9 4438.3 10029.8 10034.2 10035.0 10142.7 10148.5 5211.2 5222.5 5224.1 5226.8 5227.9 4191.0 4767.0 4900.2 4917.2 4998.3 3716.4 3793.9 3830.4 3873.1 3925.3 1102.6 1107.0 1113.0 1116.8 1120.4 953.2 972.8 998.7 1005.3 1010.8 6090.9 6113.2 6168.7 6408.3 6414.3 410.3 410.5 422.6 423.4 425.9 4331.6 4342.3 4411.7 4426.3 4446.2 10870.4 11042.8 11176.6 11228.7 11230.2 10708.4 11042.2 11052.0 11079.5 11091.3 8237.6 8549.2 8627.7 8644.2 8645.6 6078.7 6319.9 6391.1 6514.3 6517.7 10080.6 10712.9 10720.4 10720.4 10722.4 10424.7 10815.8 10854.7 10930.7 10957.5 7226.2 7944.7 8179.0 8263.5 8440.5 8999.9 9034.6 9081.0 9122.2 9139.0 7666.8 7889.8 7934.7 7999.3 8020.2 7734.1 8005.4 8027.7 8094.9 8136.2 7292.6 7305.7 7386.5 7411.0 7414.8 5190.8 5208.6 5323.4 5343.1 5449.0 5234.7 5520.1 5527.7 5595.4 5723.3 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#4] prototype.html Cycles:180 Average:4609.54 Median:5284.98 stddev:1345.02 (25.4%) stddev-sans-first:1309.72 01:26:27 INFO - PROCESS | 26351 | Values: 322.0 323.5 326.2 327.3 329.0 5334.4 5343.8 5358.6 5406.1 5413.5 5208.9 5222.6 5267.9 5277.5 5316.9 3878.7 3963.4 4088.4 4118.8 4137.9 4076.7 4092.7 4095.6 4106.3 4117.3 3911.2 4089.5 4099.3 4106.6 4107.3 3951.4 4068.8 4074.7 4075.4 4108.3 3603.6 3607.5 3609.2 3619.6 3626.1 5065.3 5118.2 5181.1 5183.5 5188.2 4435.9 4659.4 4669.5 4669.8 4680.5 5471.6 5507.9 5510.0 5514.2 5528.7 3958.8 3981.7 3991.0 3996.5 4018.3 5577.8 5581.7 5621.5 5704.0 5721.1 3950.6 3959.2 3983.8 3986.1 3996.5 4020.7 4048.1 4056.2 4077.9 4089.5 4516.4 4652.5 4669.6 4688.2 4700.3 5473.9 5511.7 5535.6 5541.2 5544.4 1405.8 1428.9 1430.8 1434.1 1437.6 917.9 927.6 946.2 960.9 976.9 5224.4 5239.6 5245.3 5246.5 5263.3 5581.6 5581.9 5584.9 5600.8 5613.0 5133.7 5210.5 5217.0 5247.1 5288.6 2933.9 2971.6 2973.9 2984.3 2988.9 5504.6 5767.1 5783.9 5789.4 5831.6 5630.3 5651.2 5661.7 5662.8 5696.2 5697.8 5721.5 5733.8 5759.2 5782.4 5313.4 5518.9 5561.4 5592.4 5592.8 5438.7 5489.7 5490.3 5496.7 5505.8 5679.0 5734.1 5734.6 5742.0 5783.8 3961.6 4052.7 4085.2 4107.6 4110.1 5562.8 5568.5 5621.8 5623.0 5650.6 5290.2 5461.2 5472.6 5488.5 5521.4 5352.4 5355.2 5401.9 5472.7 5528.0 5161.5 5242.8 5281.4 5305.9 5328.0 5478.0 5513.7 5531.9 5548.7 5569.5 5384.5 5388.9 5391.5 5444.4 5463.5 01:26:27 INFO - PROCESS | 26351 | 01:26:27 INFO - PROCESS | 26351 | [#5] yui.html Cycles:180 Average:21523.85 Median:4663.79 stddev:32273.39 (692.0%) stddev-sans-first:32326.05 01:26:27 INFO - PROCESS | 26351 | Values: 700.9 722.9 774.6 807.5 844.3 15392.4 15901.4 15927.3 15944.1 15956.6 14509.0 15724.8 15751.5 15790.8 15808.9 687.6 825.8 836.0 844.2 844.5 804.9 837.6 839.7 840.3 840.7 865.0 865.5 867.9 868.0 868.5 718.2 739.7 864.4 865.0 865.3 543.3 605.5 625.6 625.7 627.2 14992.4 14997.9 15009.5 15462.6 15475.0 10908.6 11435.2 11637.7 11862.2 11996.6 12322.2 12444.4 12500.5 12562.8 12599.4 4633.7 4677.1 4727.3 4729.6 4935.0 76637.6 76906.2 78022.2 80597.0 80716.6 11298.7 11365.9 11457.4 11498.2 11851.6 21717.7 21823.1 21849.8 21863.7 22168.6 8858.4 8927.2 8943.4 8992.4 9061.8 4590.5 4594.7 4650.4 4685.1 4707.7 3490.4 3586.9 3590.4 3606.9 3607.1 568.9 571.6 578.6 584.1 585.0 684.4 693.1 696.4 704.3 706.5 9232.2 9514.3 9712.0 9879.9 9974.8 640.4 668.5 670.7 674.9 676.8 4432.1 4478.8 4638.7 4757.6 4799.8 116341.0 122670.4 123238.0 125598.0 125849.0 105704.5 108914.0 109372.0 109544.5 109792.0 90512.0 92822.5 93359.0 93546.5 94568.0 8862.2 8927.7 9027.5 9082.6 9254.0 53281.5 54617.5 55144.4 55153.0 55683.4 69363.3 79655.6 81619.0 81911.8 84302.0 11617.2 11671.3 11676.0 11700.5 11936.5 13165.7 13381.4 13410.4 13460.5 13469.7 12282.6 12469.0 12587.6 12693.4 12693.7 12047.6 12255.8 12263.4 12365.1 12454.3 11390.5 11509.8 11897.3 11908.9 12272.4 10179.2 10212.4 10340.8 10354.0 10362.6 9153.4 10058.2 10058.5 10193.2 10209.2 01:26:27 INFO - PROCESS | 26351 | -------- Summary: end -------- 01:26:27 INFO - PROCESS | 26351 | 01:26:28 INFO - TEST-INFO | 26351: exit 0 01:26:28 INFO - TEST-OK | dromaeo_css | took 1118371ms 01:26:28 INFO - TEST-START | kraken 01:26:28 INFO - operating with platform_type : linux_ 01:26:28 INFO - Initialising browser for kraken test... 01:26:28 INFO - TEST-INFO | started process 26538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPiK8zZ/profile http://localhost:59081/getInfo.html) 01:26:34 INFO - PROCESS | 26538 | __metrics Screen width/height:1600/1200 01:26:34 INFO - PROCESS | 26538 | colorDepth:24 01:26:34 INFO - PROCESS | 26538 | Browser inner width/height: 1024/697 01:26:34 INFO - PROCESS | 26538 | __metrics 01:26:36 INFO - PROCESS | 26538 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:37 INFO - PROCESS | 26538 | console.error: PushService: 01:26:37 INFO - PROCESS | 26538 | stateChangeProcessEnqueue: Error transitioning state 01:26:37 INFO - PROCESS | 26538 | UnknownError 01:26:37 INFO - TEST-INFO | 26538: exit 0 01:26:37 INFO - Browser initialized. 01:26:37 INFO - Running cycle 1/1 for kraken test... 01:26:37 INFO - TEST-INFO | started process 26622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPiK8zZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:49 INFO - PROCESS | 26622 | RSS: Main: 173735936 01:26:49 INFO - PROCESS | 26622 | 01:26:52 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59081/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:53 INFO - PROCESS | 26622 | RSS: Main: 232587264 01:26:53 INFO - PROCESS | 26622 | 01:26:55 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59081/tests/kraken/driver.html?testName=audio-dft) 01:26:56 INFO - PROCESS | 26622 | RSS: Main: 220438528 01:26:56 INFO - PROCESS | 26622 | 01:26:59 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59081/tests/kraken/driver.html?testName=audio-fft) 01:27:00 INFO - PROCESS | 26622 | RSS: Main: 285552640 01:27:00 INFO - PROCESS | 26622 | 01:27:02 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59081/tests/kraken/driver.html?testName=audio-oscillator) 01:27:02 INFO - PROCESS | 26622 | RSS: Main: 197132288 01:27:02 INFO - PROCESS | 26622 | 01:27:05 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:27:05 INFO - PROCESS | 26622 | RSS: Main: 201478144 01:27:05 INFO - PROCESS | 26622 | 01:27:08 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59081/tests/kraken/driver.html?testName=imaging-darkroom) 01:27:09 INFO - PROCESS | 26622 | RSS: Main: 235745280 01:27:09 INFO - PROCESS | 26622 | 01:27:12 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59081/tests/kraken/driver.html?testName=imaging-desaturate) 01:27:13 INFO - PROCESS | 26622 | RSS: Main: 237821952 01:27:13 INFO - PROCESS | 26622 | 01:27:16 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59081/tests/kraken/driver.html?testName=json-parse-financial) 01:27:16 INFO - PROCESS | 26622 | RSS: Main: 237527040 01:27:16 INFO - PROCESS | 26622 | 01:27:18 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:27:18 INFO - PROCESS | 26622 | RSS: Main: 225050624 01:27:18 INFO - PROCESS | 26622 | 01:27:20 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:27:21 INFO - PROCESS | 26622 | RSS: Main: 228204544 01:27:21 INFO - PROCESS | 26622 | 01:27:23 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:27:23 INFO - PROCESS | 26622 | RSS: Main: 235245568 01:27:23 INFO - PROCESS | 26622 | 01:27:26 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:27:26 INFO - PROCESS | 26622 | RSS: Main: 238833664 01:27:26 INFO - PROCESS | 26622 | 01:27:29 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:27:30 INFO - PROCESS | 26622 | RSS: Main: 240726016 01:27:30 INFO - PROCESS | 26622 | 01:27:31 INFO - PROCESS | 26622 | Cycle 1(1): loaded http://localhost:59081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59081/tests/kraken/driver.html?testName=ai-astar) 01:27:32 INFO - PROCESS | 26622 | RSS: Main: 283197440 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | __start_tp_report 01:27:32 INFO - PROCESS | 26622 | _x_x_mozilla_page_load 01:27:32 INFO - PROCESS | 26622 | _x_x_mozilla_page_load_details 01:27:32 INFO - PROCESS | 26622 | |i|pagename|runs| 01:27:32 INFO - PROCESS | 26622 | |0;ai-astar;100;110;109;109;110;111;109;109;109;109 01:27:32 INFO - PROCESS | 26622 | |1;audio-beat-detection;155;131;125;184;127;126;153;124;162;124 01:27:32 INFO - PROCESS | 26622 | |2;audio-dft;161;161;161;160;161;162;162;160;162;161 01:27:32 INFO - PROCESS | 26622 | |3;audio-fft;75;74;75;107;75;75;75;74;97;74 01:27:32 INFO - PROCESS | 26622 | |4;audio-oscillator;85;85;117;85;85;85;122;85;85;123 01:27:32 INFO - PROCESS | 26622 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;117;117;116 01:27:32 INFO - PROCESS | 26622 | |6;imaging-darkroom;145;147;147;146;145;146;147;146;145;146 01:27:32 INFO - PROCESS | 26622 | |7;imaging-desaturate;95;96;95;95;95;95;95;94;95;95 01:27:32 INFO - PROCESS | 26622 | |8;json-parse-financial;52;51;52;52;52;52;53;52;52;53 01:27:32 INFO - PROCESS | 26622 | |9;json-stringify-tinderbox;63;62;63;62;63;63;62;63;62;62 01:27:32 INFO - PROCESS | 26622 | |10;stanford-crypto-aes;79;84;78;79;80;80;80;82;95;80 01:27:32 INFO - PROCESS | 26622 | |11;stanford-crypto-ccm;119;123;120;122;135;135;128;131;140;124 01:27:32 INFO - PROCESS | 26622 | |12;stanford-crypto-pbkdf2;163;158;156;157;163;163;159;161;159;161 01:27:32 INFO - PROCESS | 26622 | |13;stanford-crypto-sha256-iterative;64;63;62;73;66;63;62;62;61;66 01:27:32 INFO - PROCESS | 26622 | __end_tp_report 01:27:32 INFO - PROCESS | 26622 | __start_cc_report 01:27:32 INFO - PROCESS | 26622 | _x_x_mozilla_cycle_collect,1607 01:27:32 INFO - PROCESS | 26622 | __end_cc_report 01:27:32 INFO - PROCESS | 26622 | __startTimestamp1467016052225__endTimestamp 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | ------- Summary: start ------- 01:27:32 INFO - PROCESS | 26622 | Number of tests: 14 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:3.06 (2.8%) stddev-sans-first:0.73 01:27:32 INFO - PROCESS | 26622 | Values: 100.0 110.0 109.0 109.0 110.0 111.0 109.0 109.0 109.0 109.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:142.00 stddev:21.04 (14.8%) stddev-sans-first:21.71 01:27:32 INFO - PROCESS | 26622 | Values: 155.0 131.0 125.0 184.0 127.0 126.0 153.0 124.0 162.0 124.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:27:32 INFO - PROCESS | 26622 | Values: 161.0 161.0 161.0 160.0 161.0 162.0 162.0 160.0 162.0 161.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:11.79 (15.7%) stddev-sans-first:12.36 01:27:32 INFO - PROCESS | 26622 | Values: 75.0 74.0 75.0 107.0 75.0 75.0 75.0 74.0 97.0 74.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:17.30 (20.3%) stddev-sans-first:17.91 01:27:32 INFO - PROCESS | 26622 | Values: 85.0 85.0 117.0 85.0 85.0 85.0 122.0 85.0 85.0 123.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 01:27:32 INFO - PROCESS | 26622 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 116.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 01:27:32 INFO - PROCESS | 26622 | Values: 145.0 147.0 147.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 01:27:32 INFO - PROCESS | 26622 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 01:27:32 INFO - PROCESS | 26622 | Values: 52.0 51.0 52.0 52.0 52.0 52.0 53.0 52.0 52.0 53.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 01:27:32 INFO - PROCESS | 26622 | Values: 63.0 62.0 63.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.00 stddev:4.97 (6.2%) stddev-sans-first:5.17 01:27:32 INFO - PROCESS | 26622 | Values: 79.0 84.0 78.0 79.0 80.0 80.0 80.0 82.0 95.0 80.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.50 stddev:7.24 (5.6%) stddev-sans-first:6.96 01:27:32 INFO - PROCESS | 26622 | Values: 119.0 123.0 120.0 122.0 135.0 135.0 128.0 131.0 140.0 124.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.00 stddev:2.58 (1.6%) stddev-sans-first:2.50 01:27:32 INFO - PROCESS | 26622 | Values: 163.0 158.0 156.0 157.0 163.0 163.0 159.0 161.0 159.0 161.0 01:27:32 INFO - PROCESS | 26622 | 01:27:32 INFO - PROCESS | 26622 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:63.50 stddev:3.52 (5.5%) stddev-sans-first:3.73 01:27:32 INFO - PROCESS | 26622 | Values: 64.0 63.0 62.0 73.0 66.0 63.0 62.0 62.0 61.0 66.0 01:27:32 INFO - PROCESS | 26622 | -------- Summary: end -------- 01:27:32 INFO - PROCESS | 26622 | 01:27:34 INFO - TEST-INFO | 26622: exit 0 01:27:34 INFO - TEST-OK | kraken | took 65373ms 01:27:34 INFO - SUITE-END | took 1183s 01:27:34 INFO - Completed test suite (00:19:43) 01:27:34 INFO - javascript benchmark 01:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.2983828638557, 3155.7317628001624, 3156.7948083374563, 3184.4586420308547, 3213.052149615863, 5283.418823929364, 5353.9196912046355, 5457.672539647624, 5542.362628297747, 5561.332640083186, 5402.810901618444, 5405.216243644669, 5411.729413529328, 5459.481349271823, 5473.28847249857, 4859.416869975599, 4938.827141050064, 4945.406551213841, 4961.280614310923, 5094.974525127388, 4995.350604421438, 5015.949840501603, 5034.270030845525, 5039.420466646346, 5088.745562721868, 4807.30294107356, 4866.440359358684, 4895.241237608177, 4914.287428322891, 4950.529699678525, 4944.90110197794, 4946.356973593446, 4949.925751113737, 4963.578095861856, 5001.299818025479, 4947.703137811707, 4972.254161875748, 4980.726060066695, 4986.62600304975, 5015.498450154992, 5322.893542129135, 5356.35723713153, 5383.623146379755, 5398.0, 5562.4993750562235, 5782.710864456761, 5835.0372188588835, 5842.415758424166, 5849.181114643953, 5850.385709500526, 5845.357010728816, 5899.911501327483, 5912.586118971673, 5913.0539113742025, 5921.822345329647, 5229.712365819878, 5289.841304760864, 5369.677819330853, 5372.785088596491, 5440.401555828856, 5920.052791553331, 5923.526117910643, 5927.0, 5929.199558059693, 5934.554908381889, 5559.944400555943, 5652.123920792284, 5656.43435656431, 5693.857653558694, 5695.5443564514735, 5762.9135562966585, 5819.272590926134, 5827.679477628772, 5842.211301474332, 5849.034909239927, 5823.737931793079, 5825.359210486843, 5829.7376618052285, 5835.4748072673665, 5836.2412886325355, 5660.745266463019, 5758.7696492140685, 5774.797882074107, 5834.095715164156, 5840.503557197686, 4432.3794668746405, 4448.399466072104, 4448.844290449819, 4489.820407183742, 4493.752843593568, 3926.823292951824, 3943.881683549498, 3952.5256969163884, 3959.9010024749036, 3981.820818063194, 5335.9466405336225, 5357.330333708286, 5371.194320851903, 5519.116941289374, 5527.115661494222, 5689.943100569024, 5725.541956643458, 5748.166515855178, 5748.281464816898, 5798.1302804579655, 5251.264822924793, 5302.681839089667, 5309.309789727311, 5339.14573668219, 5391.919121213185, 4679.789409476582, 4773.0, 4803.543663351976, 4842.491538388418, 4846.878828029327, 5938.821835345033, 5958.851028724316, 5970.552208584373, 5978.163057172, 6009.0, 5738.741756621045, 5751.798687045934, 5752.223449834386, 5753.05074662676, 5763.394843541536, 5894.970525147347, 5914.940850591611, 5919.200907877382, 5958.433948774859, 5982.760689572368, 5697.059985102412, 5720.11338242573, 5722.570807189394, 5723.341815691082, 5724.169995350568, 5723.914141287801, 5780.884382312414, 5783.16144159103, 5787.074068149076, 5791.189233507228, 5593.916091258553, 5614.214010038516, 5629.971850140723, 5659.603827732019, 5683.431656834284, 5628.409017053151, 5637.57718171147, 5639.125935480007, 5642.605017648725, 5678.829635110953, 5449.618526703092, 5532.0595498766115, 5572.164175373727, 5585.162225666182, 5592.0, 5681.460261275172, 5711.143328500758, 5744.281964754406, 5807.303123625192, 5810.6513609183585, 5592.356878958972, 5608.915866262091, 5612.5509959202345, 5613.607047506635, 5615.410381910004], "value": 5334.153565762386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.573261519091, 609.3997412548639, 619.0590302739838, 634.0, 634.0330995232268, 32753.0, 36519.08702282441, 42996.785016074915, 44024.05675233842, 44117.77941110298, 45974.0, 46299.76850115753, 46378.30432543506, 46379.536204637945, 46406.0, 8934.776630584254, 9090.13643703847, 9093.18161365477, 9093.818123637524, 9095.0, 8840.778980525474, 8948.463092214455, 8952.14954579314, 8966.0585638508, 8974.551272436385, 8989.730308090768, 9055.275577953747, 9057.773555661095, 9059.864102038475, 9060.909390906072, 9038.593263303168, 9108.271338292921, 9109.362344635878, 9113.589888455002, 9118.726438206864, 9000.099990001014, 9000.144986226298, 9051.23064539515, 9052.049534798816, 9053.909460905372, 42835.0, 43082.78458607687, 43187.78406107981, 43231.35152972708, 43434.34848477275, 3442.5008373785913, 3548.929021419583, 3568.536090308269, 3721.2371463849845, 3970.6426421621904, 31245.843770781226, 34325.313493729984, 34327.0, 34421.6557834421, 34444.13889652754, 4339.1104823511105, 4497.806190315484, 4587.564181402761, 4594.333821595883, 4696.272077827942, 380826.0, 389181.0, 389811.0, 391962.0, 392553.0, 67184.6640766793, 68049.0, 68116.0, 68176.6591167041, 68239.0, 47887.521124788305, 47943.28085078727, 47959.520404795505, 47979.760101199274, 48109.0, 16603.252853621616, 17694.29222831098, 17957.64084718298, 17969.0, 17987.1006449677, 12568.74862502763, 12992.285424301564, 12995.0, 13481.191128532319, 13747.518836840864, 14429.405373551983, 19056.809431905782, 19361.419157425298, 19788.0, 19911.701324480146, 7340.96329518349, 7408.9629551851895, 7718.3053525183, 7724.6523906424345, 7837.686492540349, 942.8114377124602, 1071.7856428714288, 1122.2763904089081, 1127.7518945832069, 1142.5715356741223, 33337.0, 33435.331293373994, 33495.330093398, 33558.225877280805, 33583.734424902024, 1110.1008183371496, 1111.5387114347616, 1142.8914253145938, 1174.2015429508017, 1238.8203710461933, 16355.34578616842, 17175.398861040052, 17269.481915542554, 17312.0, 17388.826111738974, 581234.0, 584816.0, 585410.0, 585437.0, 587033.0, 61750.691246544375, 62121.689391552754, 62213.0, 62241.0, 62292.0, 1275.993620031894, 1330.9267990260628, 1344.2405041151717, 1369.383777300219, 1386.9805692815974, 31094.0, 34411.13972150616, 34603.826980864935, 34604.82697586496, 34829.0, 54508.0, 55626.0, 55645.0, 55671.0, 55673.721631391585, 503035.0, 516253.0, 516886.0, 516929.0, 517922.0, 39350.212995739355, 45250.32124518201, 45637.77181114073, 45873.77063114663, 50541.241881372545, 49823.50176498334, 50780.746096269286, 51180.48819511757, 51303.74348128385, 51421.1718355494, 42875.78562107169, 43098.0, 43842.342364863915, 44535.0, 44831.77584112059, 41940.0, 41970.790146049076, 42318.0, 42405.5759442414, 43043.0, 42920.35619465648, 42989.570104299804, 43460.0, 45674.54325456703, 46801.531984679714, 36346.63653363432, 39447.60552394554, 39505.604943950195, 39616.0, 40058.19883602254, 28294.71705283003, 28817.711822882342, 29106.7089329104, 29293.414131717673, 29623.703762962094], "value": 21134.76407228062, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.18743857233386, 376.7080512602734, 381.6164754421807, 392.6230818414322, 403.73555321264564, 17079.57301067474, 18837.434876953695, 19056.42830715079, 19188.616227675437, 19333.90333048333, 19048.809511904878, 19406.126724297406, 19762.505937351572, 19767.802321976775, 19813.108410121542, 5604.3835178130375, 5683.976884160849, 5770.653760774346, 5860.472557469827, 5863.237779088712, 5707.1153971134545, 5731.197632331477, 5743.368229494752, 5756.884862302752, 5772.82681519553, 5465.398806131342, 5706.629069110515, 5721.485066344028, 5746.626469279504, 5755.913661295084, 5694.544436445095, 5704.971475142639, 5726.055200891848, 5737.627054241482, 5754.136879468071, 5099.46455622158, 5113.51421614946, 6557.704903279317, 7042.6830792614455, 7044.64776761165, 25462.490750184894, 25861.870690646614, 26292.21123366302, 26401.73598264012, 26576.06983755559, 2294.770522947692, 2396.6165413533927, 2425.514897020585, 2500.624906264057, 2523.775968655201, 14959.700805983928, 15981.360745570164, 16156.27296771648, 16236.675266494722, 16959.406420775213, 2084.812366886972, 2109.694094356325, 2155.5796619659172, 2202.064122747826, 2224.5439684864564, 97849.0, 101722.0, 102294.48852755688, 103219.48390258076, 104725.47637261765, 17642.735358969625, 17925.551861203574, 18432.447026589223, 19294.71057934132, 19835.0, 32287.838560807046, 32434.0, 32572.511412328833, 32702.182445439055, 32702.672973270437, 10203.744906377251, 10372.688819335432, 10541.606349523348, 10558.788824223473, 10575.0, 8600.483970961763, 8672.0, 8749.781255468537, 8762.211400973943, 8770.429922055173, 8896.644134234559, 9105.681301154427, 9134.269258459308, 9145.222656074175, 9291.535423228812, 3207.2302647364463, 3347.5480810090326, 3402.302527981758, 3488.581370235588, 3573.6069032406413, 873.4671850171391, 889.7686601483531, 1032.5147180825, 1067.3595842494597, 1083.664064140119, 18865.90567047156, 19599.216031358872, 19705.901470492558, 19774.40676779699, 20070.39788806309, 1003.8694969654044, 1018.7096677446892, 1033.503918119307, 1040.147079394889, 1057.9523921423402, 10179.338343007681, 11022.50398732059, 11029.724256893642, 11054.944725276482, 11154.944225278983, 466787.0, 473560.0, 474935.0, 476329.0, 479098.0, 96642.0, 98909.99999999856, 99441.0, 99920.0, 100199.0, 998.6953979036464, 1005.9748506287401, 1008.8688470498935, 1018.0582960761266, 1026.7381817636456, 16943.15284235808, 17169.656606868044, 17538.82461175372, 17571.209295581986, 17779.199936002653, 41216.79391603023, 41549.792251038554, 41697.0, 42781.572184279, 45668.54331456643, 58208.4179158203, 59022.704886475294, 60073.692262313576, 60818.391816081275, 60940.39059609347, 8220.219079187467, 8229.95885020571, 8234.0, 8288.171182881664, 8436.0, 9007.279417646703, 13231.3384330785, 14303.426623071246, 14349.928250358682, 14613.050151740528, 12262.938685306517, 12416.75166496683, 12503.187292825936, 12585.748285034431, 12675.30285834288, 11942.283462991902, 12108.21296615717, 12430.067744918986, 12593.559225427432, 12689.175203612105, 12563.246205227715, 12642.431090600761, 12773.425195866394, 12776.936115319364, 12843.743125137258, 8520.914790852261, 8605.612747426256, 8630.0, 8786.604602792762, 8817.515036673045, 11809.468573914022, 12140.75718485643, 12333.383330833243, 12410.069244806857, 12488.375581221084], "value": 10372.01638186726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.1114858619019, 1503.804505414296, 1509.0492989416668, 1672.172274724011, 1822.7903791064023, 8494.745157645273, 8880.733577992654, 8900.24347930426, 9158.679446219367, 9176.4035337703, 8575.528345940971, 8799.252063574588, 8799.252063574604, 8818.86771698425, 8823.691170809023, 2004.1782869023702, 2233.3858188998074, 2321.5821152192684, 2323.616603260464, 2351.0360752091647, 2313.363824948136, 2316.247219653611, 2317.9884100579475, 2320.454693147109, 2321.5472982768365, 2253.6281513550243, 2307.976920230793, 2322.0, 2323.628219484874, 2323.744388117306, 1922.692369220925, 2136.2736669532433, 2197.0, 2203.2398822406244, 2251.2570851619007, 2252.831037672181, 2252.8986195621237, 2278.168468508982, 2278.2140161644206, 2278.646809744492, 9191.0, 9224.723258302261, 9247.21398681113, 9255.259579233712, 9265.722028339093, 5121.129408000649, 5270.762815673265, 5271.578273738091, 5272.209168624737, 5278.947210527884, 3356.1777364545596, 3404.0, 3452.2405070884365, 3500.7899526028264, 3509.999650099735, 1176.1707995862896, 1181.8699943006263, 1184.4373922386796, 1198.5445530698366, 2177.4665207024223, 12132.150749447543, 12562.371881405894, 12573.308468034254, 12631.810522842165, 12641.747165056648, 4308.138372325548, 4319.654427645781, 4354.738715677069, 4429.933550996738, 4438.289873620205, 10029.79940401188, 10034.24743144267, 10035.046670566284, 10142.746431339276, 10148.54331555067, 5211.1662134059125, 5222.503862133091, 5224.111900976843, 5226.817061402832, 5227.947720522822, 4191.0, 4767.0, 4900.240462728283, 4917.164082106051, 4998.2502624606595, 3716.4239542870896, 3793.867214647474, 3830.3871380578976, 3873.1285460771664, 3925.2738243425056, 1102.5534658463334, 1106.9944650276698, 1113.0205419231186, 1116.8045592021365, 1120.4117838135044, 953.1850268020881, 972.8103019911049, 998.7103739915489, 1005.3364779245662, 1010.8260359481792, 6090.939090609126, 6113.205283313141, 6168.722407491674, 6408.2630497492455, 6414.294427612959, 410.25333892316297, 410.50534106401716, 422.6449782182981, 423.3924318602815, 425.8658522565382, 4331.610155085994, 4342.34864770287, 4411.713238639478, 4426.26966550522, 4446.155230506258, 10870.402127883042, 11042.834357484644, 11176.552937882394, 11228.719282018015, 11230.213885028134, 10708.411037393018, 11042.171837112248, 11052.0, 11079.50142243601, 11091.33451992883, 8237.588120594066, 8549.187827156411, 8627.741167764978, 8644.222020018104, 8645.573480375793, 6078.665673388006, 6319.905201422074, 6391.137196478602, 6514.2834288229205, 6517.674116294261, 10080.647177348757, 10712.8928710715, 10720.35677859331, 10720.35677859331, 10722.410267435365, 10424.739381515523, 10815.837762433726, 10854.728631784268, 10930.726731831768, 10957.452127393757, 7226.168990566152, 7944.721934732257, 8179.0, 8263.504189748393, 8440.493570385797, 8999.910000900169, 9034.593443294936, 9081.046490118442, 9122.179003889682, 9138.954305228432, 7666.846663066819, 7889.842203156019, 7934.682612695427, 7999.280064794197, 8020.15788342239, 7734.149243583314, 8005.439619226599, 8027.678892844455, 8094.878576821235, 8136.1863813618165, 7292.635368231673, 7305.744298949511, 7386.482946193715, 7410.96294518524, 7414.8146296340865, 5190.766415511386, 5208.609354298367, 5323.361196656426, 5343.118385466354, 5448.972755136199, 5234.712090835041, 5520.1443776214755, 5527.700990267364, 5595.384507704231, 5723.3418156912485], "value": 4616.545926943175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.9935601287974, 323.5179582422191, 326.2496258605207, 327.2522286575175, 328.99342013159753, 5334.359876814778, 5343.786248550063, 5358.598105142115, 5406.135018397063, 5413.539849112825, 5208.85405210854, 5222.556082732972, 5267.920981185285, 5277.498637629428, 5316.946830531693, 3878.747881387708, 3963.4054891766177, 4088.425956006944, 4118.846722917588, 4137.855175068873, 4076.653484453825, 4092.6725861930972, 4095.6313931746135, 4106.322456794625, 4117.341225403936, 3911.2373087247997, 4089.5297040840387, 4099.323611604082, 4106.630403263705, 4107.260693075245, 3951.3677811550156, 4068.8403804915456, 4074.714769966118, 4075.3683179107284, 4108.337037462472, 3603.56757189139, 3607.494950706903, 3609.151849315409, 3619.6380361963857, 3626.1478552540134, 5065.265536497224, 5118.232265160219, 5181.145111056671, 5183.507566781187, 5188.22176673502, 4435.889102772424, 4659.394278743742, 4669.486356500782, 4669.789859456333, 4680.478844375558, 5471.644343117685, 5507.889842203173, 5510.0, 5514.228008078872, 5528.723563821833, 3958.8218530166214, 3981.6615587675083, 3991.0044977511243, 3996.48045754053, 4018.2566225248424, 5577.776888924438, 5581.6930068846195, 5621.4659607337235, 5703.999999999958, 5721.141828725683, 3950.585188555218, 3959.1883663848844, 3983.8008099594904, 3986.123052928351, 3996.5204175498543, 4020.718549701551, 4048.149888523443, 4056.1887622475624, 4077.857274995361, 4089.488813898263, 4516.39667917891, 4652.488226295105, 4669.556392142741, 4688.249880019249, 4700.318453824177, 5473.863153421116, 5511.696856672921, 5535.612507124462, 5541.224228607998, 5544.362398324163, 1405.8172437583048, 1428.8928330375263, 1430.790981620529, 1434.0965191929017, 1437.5552569667418, 917.9219766319804, 927.6057675488025, 946.2288235088381, 960.865478832964, 976.9302613638055, 5224.373075230997, 5239.554637855825, 5245.291885595472, 5246.475352464723, 5263.315768950012, 5581.6371935824045, 5581.888362232733, 5584.944150558524, 5600.803971860965, 5612.971935140298, 5133.743312834344, 5210.505002024802, 5216.9739151304, 5247.134222853263, 5288.603354748409, 2933.882644694231, 2971.5542668599883, 2973.925651858721, 2984.2688541307084, 2988.8804447822276, 5504.587155963319, 5767.134929760486, 5783.94216057834, 5789.421057894261, 5831.620944638585, 5630.296212973379, 5651.237082993825, 5661.745221464962, 5662.8301150965535, 5696.202531645573, 5697.800576979786, 5721.485066344049, 5733.77064917407, 5759.22250496186, 5782.3639399666845, 5313.388960269618, 5518.944810551843, 5561.360443549043, 5592.384837667934, 5592.832215033555, 5438.728063596884, 5489.682476205761, 5490.258815059916, 5496.6701997880255, 5505.779768809202, 5679.0, 5734.139879018181, 5734.595024219093, 5741.971290143522, 5783.797567085132, 3961.6038396161307, 4052.675785937177, 4085.20338533983, 4107.568705285902, 4110.116324990141, 5562.833115006394, 5568.49883510486, 5621.80323688669, 5622.971885140548, 5650.63270887391, 5290.206469029677, 5461.15352120422, 5472.644278121909, 5488.518100113027, 5521.365043020104, 5352.384475785335, 5355.2234925934745, 5401.918971215357, 5472.72636368188, 5527.972360138174, 5161.458046905171, 5242.816501422432, 5281.366236051698, 5305.867353316198, 5328.014317351302, 5477.972610136924, 5513.696746678811, 5531.944680553143, 5548.696056426817, 5569.4709002646305, 5384.488473595002, 5388.865278368072, 5391.487808658171, 5444.401115877171, 5463.541406367231], "value": 4181.431474261224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9299070092989, 722.8626560953415, 774.5894675821817, 807.4590024683463, 844.3203221406767, 15392.384304627802, 15901.363945442183, 15927.283272252747, 15944.123073230967, 15956.601084972881, 14509.0, 15724.842751572482, 15751.527454176394, 15790.842091579081, 15808.920955395235, 687.6355531568277, 825.7646570727344, 836.017679226909, 844.1980118887051, 844.4553263145268, 804.9235322644339, 837.5728378526965, 839.7438781171741, 840.277361469136, 840.7057529864529, 864.9567521623893, 865.5412631305418, 867.8915135608049, 868.0364795077459, 868.4962721621445, 718.1812733483832, 739.663453128825, 864.446754077391, 864.9827003459927, 865.2558799432483, 543.2503145659005, 605.461139585769, 625.5777350288582, 625.7090452939404, 627.244170774216, 14992.400303987828, 14997.850021499755, 15009.474668386554, 15462.61343466411, 15475.0, 10908.61819836302, 11435.199536032482, 11637.650870473899, 11862.22895511789, 11996.64010079699, 12322.199057061353, 12444.440000200013, 12500.49998000079, 12562.81155782664, 12599.37003149848, 4633.675642705012, 4677.134730074947, 4727.314539391769, 4729.55069268419, 4935.0, 76637.61681191614, 76906.23093769046, 78022.21977780206, 80597.0, 80716.59641701754, 11298.661040168809, 11365.886341136647, 11457.369844658457, 11498.195126341243, 11851.644450666494, 21717.67423488649, 21823.12707491714, 21849.78150218509, 21863.672044919338, 22168.556628867656, 8858.379913406, 8927.24118449926, 8943.418677785923, 8992.370534062684, 9061.818763624691, 4590.495045544987, 4594.678372513892, 4650.441946966385, 4685.109829132454, 4707.741074240881, 3490.3717330880686, 3586.8565257389932, 3590.4434812604086, 3606.945895811565, 3607.0801945503727, 568.8720037991419, 571.562754492805, 578.5574035862569, 584.0742423259097, 585.0463744097094, 684.4079870911626, 693.0967563071761, 696.4150113904344, 704.327367364166, 706.4877963476439, 9232.169104780467, 9514.346912180905, 9711.951440242894, 9879.851802222973, 9974.750631234132, 640.3916279534461, 668.4552090046597, 670.686132841698, 674.8953912143626, 676.7868121541699, 4432.086198763662, 4478.776061196927, 4638.744869032235, 4757.5718185363485, 4799.784009719571, 116341.0, 122670.38664806618, 123238.0, 125598.0, 125849.0, 105704.47147764366, 108914.0, 109372.0, 109544.4522777381, 109792.0, 90512.0, 92822.53588732013, 93359.0, 93546.53226733823, 94568.0, 8862.158094980967, 8927.687530936386, 9027.503487307999, 9082.59128339213, 9254.0, 53281.46718532765, 54617.453825461234, 55144.44855551393, 55153.0, 55683.44316556783, 69363.30636693568, 79655.60172199101, 81619.0, 81911.77132343139, 84301.99131082537, 11617.186796924134, 11671.299722016705, 11676.0, 11700.47347869331, 11936.522539098687, 13165.736685266433, 13381.39783709755, 13410.396532156272, 13460.528881489492, 13469.663258418226, 12282.570110046105, 12469.002479801775, 12587.622371328875, 12693.365331733561, 12693.746125077261, 12047.578334758242, 12255.75488490243, 12263.38683065861, 12365.07261955339, 12454.25274483534, 11390.544378224778, 11509.769804603693, 11897.345645989208, 11908.940455297668, 12272.44773985155, 10179.236557258087, 10212.438315892698, 10340.793184136426, 10354.0, 10362.585496580354, 9153.405028673114, 10058.195344372287, 10058.547365368722, 10193.23550733683, 10209.183265338903], "value": 7476.395526313253, "unit": "score"}], "name": "dromaeo_css", "value": 7433.927285268985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 109.0, 110.0, 111.0, 109.0, 109.0, 109.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 125.0, 184.0, 127.0, 126.0, 153.0, 124.0, 162.0, 124.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 160.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 107.0, 75.0, 75.0, 75.0, 74.0, 97.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 85.0, 85.0, 122.0, 85.0, 85.0, 123.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 52.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 78.0, 79.0, 80.0, 80.0, 80.0, 82.0, 95.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 123.0, 120.0, 122.0, 135.0, 135.0, 128.0, 131.0, 140.0, 124.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 156.0, 157.0, 163.0, 163.0, 159.0, 161.0, 159.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 73.0, 66.0, 63.0, 62.0, 62.0, 61.0, 66.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1493.0000000000002, "alertThreshold": 2.0}]} 01:27:34 INFO - Return code: 0 01:27:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:27:34 INFO - # TBPL SUCCESS # 01:27:34 INFO - Running post-action listener: _resource_record_post_action 01:27:34 INFO - ##### 01:27:34 INFO - ##### Finished run-tests step (success) 01:27:34 INFO - ##### 01:27:34 INFO - Running post-run listener: _resource_record_post_run 01:27:34 INFO - Total resource usage - Wall time: 1210s; CPU: 14.0%; Read bytes: 0; Write bytes: 564359168; Read time: 0; Write time: 4337336 01:27:34 INFO - TinderboxPrint: CPU usage
13.7% 01:27:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:27:34 INFO - TinderboxPrint: I/O write bytes / time
564,359,168 / 4,337,336 01:27:34 INFO - TinderboxPrint: CPU idle
8,336.3 (86.3%) 01:27:34 INFO - TinderboxPrint: CPU user
1,209.1 (12.5%) 01:27:34 INFO - TinderboxPrint: Swap in / out
0 / 0 01:27:34 INFO - install - Wall time: 24s; CPU: 23.0%; Read bytes: 0; Write bytes: 255250432; Read time: 0; Write time: 2410180 01:27:34 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292126720; Read time: 0; Write time: 1802268 01:27:35 INFO - Running post-run listener: _upload_blobber_files 01:27:35 INFO - Blob upload gear active. 01:27:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:27:35 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:27:35 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:27:35 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:27:35 INFO - (blobuploader) - INFO - Open directory for files ... 01:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:36 INFO - (blobuploader) - INFO - Done attempting. 01:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:39 INFO - (blobuploader) - INFO - Done attempting. 01:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:40 INFO - (blobuploader) - INFO - Done attempting. 01:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 01:27:40 INFO - Return code: 0 01:27:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb91e1d256d36c82067ce947cb6ee094f3650669599ff542f6a05b131619ffafdeda01336979434768dcbd38849398d120bc72852d9169207d56db98172dfbb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76326e7c34f6a7930fe7622e4553d66cf65d0814948d0027058aa5080b6449d46381bb69ac6b97cea5f948b0fc76d3ed5248d924fe37d731f0e6201a479fe98d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aeab10381db7cf136cb25c0713b751f9af3577646d4ae845853e1016816b68732254f11a8270058752831080c7d602ab6b5ea81cd9925f8289e8e2ce78f2da08"} 01:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:27:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:27:40 INFO - Contents: 01:27:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb91e1d256d36c82067ce947cb6ee094f3650669599ff542f6a05b131619ffafdeda01336979434768dcbd38849398d120bc72852d9169207d56db98172dfbb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76326e7c34f6a7930fe7622e4553d66cf65d0814948d0027058aa5080b6449d46381bb69ac6b97cea5f948b0fc76d3ed5248d924fe37d731f0e6201a479fe98d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aeab10381db7cf136cb25c0713b751f9af3577646d4ae845853e1016816b68732254f11a8270058752831080c7d602ab6b5ea81cd9925f8289e8e2ce78f2da08"} 01:27:40 INFO - Running post-run listener: copy_logs_to_upload_dir 01:27:40 INFO - Copying logs to upload dir... 01:27:40 INFO - mkdir: /builds/slave/test/build/upload/logs 01:27:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.986298 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-27 01:27:39.388606) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:39.392239) ========= 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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb91e1d256d36c82067ce947cb6ee094f3650669599ff542f6a05b131619ffafdeda01336979434768dcbd38849398d120bc72852d9169207d56db98172dfbb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76326e7c34f6a7930fe7622e4553d66cf65d0814948d0027058aa5080b6449d46381bb69ac6b97cea5f948b0fc76d3ed5248d924fe37d731f0e6201a479fe98d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aeab10381db7cf136cb25c0713b751f9af3577646d4ae845853e1016816b68732254f11a8270058752831080c7d602ab6b5ea81cd9925f8289e8e2ce78f2da08"} build_url:https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb91e1d256d36c82067ce947cb6ee094f3650669599ff542f6a05b131619ffafdeda01336979434768dcbd38849398d120bc72852d9169207d56db98172dfbb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/76326e7c34f6a7930fe7622e4553d66cf65d0814948d0027058aa5080b6449d46381bb69ac6b97cea5f948b0fc76d3ed5248d924fe37d731f0e6201a479fe98d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aeab10381db7cf136cb25c0713b751f9af3577646d4ae845853e1016816b68732254f11a8270058752831080c7d602ab6b5ea81cd9925f8289e8e2ce78f2da08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:39.420182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:39.420700) ========= 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=33d5923976266a1c518c4bf7000001ab-1467014804.919122-299619292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:39.504130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:27:39.504660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:27:39.505110) ========= ========= Total master_lag: 0.17 =========