builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1469099218.22 results: success (0) buildid: 20160721025319 builduid: 1b089529a52c40cfb489e8abcd4a19c6 revision: 29ead859749af91a4e70d10a278a0ca3fca9d2b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.225276) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.226264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.226956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.245197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.245771) ========= 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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 04:06:58-- 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% 224M=0s 2016-07-21 04:06:58 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.351767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.352126) ========= 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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014384 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.404218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:58.404972) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 29ead859749af91a4e70d10a278a0ca3fca9d2b4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 29ead859749af91a4e70d10a278a0ca3fca9d2b4 --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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 04:06:58,873 truncating revision to first 12 chars 2016-07-21 04:06:58,873 Setting DEBUG logging. 2016-07-21 04:06:58,873 attempt 1/10 2016-07-21 04:06:58,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/29ead859749a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 04:06:59,182 unpacking tar archive at: autoland-29ead859749a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:59.071661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:59.072469) ========= script_repo_revision: 29ead859749af91a4e70d10a278a0ca3fca9d2b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:59.073563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:59.074031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:06:59.085831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-21 04:06:59.086528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:59 INFO - MultiFileLogger online at 20160721 04:06:59 in /builds/slave/test 04:06:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 04:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:59 INFO - {'append_to_log': False, 04:06:59 INFO - 'base_work_dir': '/builds/slave/test', 04:06:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 04:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:59 INFO - 'branch': 'Autoland-Non-PGO', 04:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:59 INFO - 'config_files': ('talos/linux_config.py',), 04:06:59 INFO - 'default_actions': ('clobber', 04:06:59 INFO - 'read-buildbot-config', 04:06:59 INFO - 'download-and-extract', 04:06:59 INFO - 'populate-webroot', 04:06:59 INFO - 'create-virtualenv', 04:06:59 INFO - 'install', 04:06:59 INFO - 'run-tests'), 04:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:59 INFO - 'download_minidump_stackwalk': True, 04:06:59 INFO - 'download_symbols': 'ondemand', 04:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:59 INFO - 'installer_path': 'installer.exe', 04:06:59 INFO - 'log_level': 'info', 04:06:59 INFO - 'log_name': 'talos', 04:06:59 INFO - 'log_to_console': True, 04:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:59 INFO - 'opt_config_files': (), 04:06:59 INFO - 'pip_index': False, 04:06:59 INFO - 'sps_profile': False, 04:06:59 INFO - 'sps_profile_interval': 0, 04:06:59 INFO - 'suite': 'dromaeojs-e10s', 04:06:59 INFO - 'system_bits': '32', 04:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:59 INFO - 'title': 'talos-linux64-ix-026', 04:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:59 INFO - 'use_talos_json': True, 04:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:59 INFO - 'work_dir': 'build'} 04:06:59 INFO - [mozharness: 2016-07-21 11:06:59.653617Z] Running clobber step. 04:06:59 INFO - Running pre-action listener: _resource_record_pre_action 04:06:59 INFO - Running main action method: clobber 04:06:59 INFO - rmtree: /builds/slave/test/build 04:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:00 INFO - Running post-action listener: _resource_record_post_action 04:07:00 INFO - [mozharness: 2016-07-21 11:07:00.129015Z] Finished clobber step (success) 04:07:00 INFO - [mozharness: 2016-07-21 11:07:00.129115Z] Running read-buildbot-config step. 04:07:00 INFO - Running pre-action listener: _resource_record_pre_action 04:07:00 INFO - Running main action method: read_buildbot_config 04:07:00 INFO - Using buildbot properties: 04:07:00 INFO - { 04:07:00 INFO - "project": "", 04:07:00 INFO - "product": "firefox", 04:07:00 INFO - "script_repo_revision": "production", 04:07:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 04:07:00 INFO - "repository": "", 04:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 04:07:00 INFO - "buildid": "20160721025319", 04:07:00 INFO - "pgo_build": "False", 04:07:00 INFO - "basedir": "/builds/slave/test", 04:07:00 INFO - "buildnumber": 123, 04:07:00 INFO - "slavename": "talos-linux64-ix-026", 04:07:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:07:00 INFO - "platform": "ubuntu64_hw", 04:07:00 INFO - "scheduler": "tests-autoland-linux64-talos", 04:07:00 INFO - "branch": "autoland", 04:07:00 INFO - "repo_path": "integration/autoland", 04:07:00 INFO - "revision": "29ead859749af91a4e70d10a278a0ca3fca9d2b4", 04:07:00 INFO - "stage_platform": "linux64", 04:07:00 INFO - "builduid": "1b089529a52c40cfb489e8abcd4a19c6", 04:07:00 INFO - "slavebuilddir": "test" 04:07:00 INFO - } 04:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:07:00 INFO - Running post-action listener: _resource_record_post_action 04:07:00 INFO - [mozharness: 2016-07-21 11:07:00.131573Z] Finished read-buildbot-config step (success) 04:07:00 INFO - [mozharness: 2016-07-21 11:07:00.131662Z] Running download-and-extract step. 04:07:00 INFO - Running pre-action listener: _resource_record_pre_action 04:07:00 INFO - Running main action method: download_and_extract 04:07:00 INFO - mkdir: /builds/slave/test/build/tests 04:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:00 INFO - https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:00 INFO - Downloaded 1361 bytes. 04:07:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:07:00 INFO - Using the following test package requirements: 04:07:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:07:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'jsshell-linux-x86_64.zip'], 04:07:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:07:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:07:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:00 INFO - https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:01 INFO - Downloaded 22730093 bytes. 04:07:01 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'] 04:07:01 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 04:07:02 INFO - Return code: 0 04:07:02 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 04: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')]} 04:07:02 INFO - https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:03 INFO - Downloaded 22730093 bytes. 04:07:03 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'] 04:07:03 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 04:07:05 INFO - Return code: 0 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:05 INFO - Downloaded 14403317 bytes. 04:07:05 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'] 04:07:05 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 04:07:06 INFO - Return code: 0 04:07:06 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')]} 04:07:06 INFO - https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CsEth1LVQlStwOemJ2oQww/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 04:07:07 INFO - Downloaded 57144092 bytes. 04:07:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:07:07 INFO - mkdir: /builds/slave/test/properties 04:07:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:07 INFO - Contents: 04:07:07 INFO - build_url:https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:07:08 INFO - Running post-action listener: _resource_record_post_action 04:07:08 INFO - Running post-action listener: set_extra_try_arguments 04:07:08 INFO - [mozharness: 2016-07-21 11:07:08.081140Z] Finished download-and-extract step (success) 04:07:08 INFO - [mozharness: 2016-07-21 11:07:08.081410Z] Running populate-webroot step. 04:07:08 INFO - Running pre-action listener: _resource_record_pre_action 04:07:08 INFO - Running main action method: populate_webroot 04:07:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:08 INFO - '--tppagecycles', 04:07:08 INFO - '7'], 04:07:08 INFO - 'tests': ['tsvgm']}}, 04:07:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['damp', 'tps']}, 04:07:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['damp', 'tps']}, 04:07:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['dromaeo_dom']}, 04:07:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['basic_compositor_video']}, 04:07:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:07:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore', 04:07:08 INFO - 'tabpaint']}, 04:07:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['tsvgx', 04:07:08 INFO - 'tsvgr_opacity', 04:07:08 INFO - 'tart', 04:07:08 INFO - 'tscrollx', 04:07:08 INFO - 'cart']}, 04:07:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:08 INFO - 'tsvgr_opacity', 04:07:08 INFO - 'tart', 04:07:08 INFO - 'tscrollx', 04:07:08 INFO - 'cart']}, 04:07:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--disable-e10s'], 04:07:08 INFO - 'tests': ['tp5o']}, 04:07:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['tp5o']}, 04:07:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--disable-e10s', 04:07:08 INFO - '--xperf_path', 04:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:08 INFO - 'tests': ['tp5n']}, 04:07:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--xperf_path', 04:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:08 INFO - 'tests': ['tp5n']}}, 04:07:08 INFO - 'talos.zip': {'path': '', 04:07:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:08 INFO - Running post-action listener: _resource_record_post_action 04:07:08 INFO - [mozharness: 2016-07-21 11:07:08.099805Z] Finished populate-webroot step (success) 04:07:08 INFO - [mozharness: 2016-07-21 11:07:08.099895Z] Running create-virtualenv step. 04:07:08 INFO - Running pre-action listener: _resource_record_pre_action 04:07:08 INFO - Running main action method: create_virtualenv 04:07:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:08 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 04:07:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:08 INFO - Using real prefix '/usr' 04:07:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:10 INFO - Installing pip.................done. 04:07:10 INFO - Return code: 0 04:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:10 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')]} 04:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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')]} 04:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:10 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 04:07:10 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 04:07:10 INFO - Using env: {'DISPLAY': ':0', 04:07:10 INFO - 'HOME': '/home/cltbld', 04:07:10 INFO - 'LANG': 'en_US.UTF-8', 04:07:10 INFO - 'LANGUAGE': 'en_US:en', 04:07:10 INFO - 'LOGNAME': 'cltbld', 04:07:10 INFO - 'MAIL': '/var/mail/cltbld', 04:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:10 INFO - 'MOZ_NO_REMOTE': '1', 04:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:10 INFO - 'NO_EM_RESTART': '1', 04:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:10 INFO - 'PWD': '/builds/slave/test', 04:07:10 INFO - 'SHELL': '/bin/bash', 04:07:10 INFO - 'SHLVL': '1', 04:07:10 INFO - 'TERM': 'linux', 04:07:10 INFO - 'TMOUT': '86400', 04:07:10 INFO - 'USER': 'cltbld', 04:07:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:10 INFO - '_': '/tools/buildbot/bin/python'} 04:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:10 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 04:07:10 INFO - Cleaning up... 04:07:10 INFO - Return code: 0 04:07:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:07:10 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')]} 04:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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')]} 04:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:10 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 04:07:10 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 04:07:10 INFO - Using env: {'DISPLAY': ':0', 04:07:10 INFO - 'HOME': '/home/cltbld', 04:07:10 INFO - 'LANG': 'en_US.UTF-8', 04:07:10 INFO - 'LANGUAGE': 'en_US:en', 04:07:10 INFO - 'LOGNAME': 'cltbld', 04:07:10 INFO - 'MAIL': '/var/mail/cltbld', 04:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:10 INFO - 'MOZ_NO_REMOTE': '1', 04:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:11 INFO - 'NO_EM_RESTART': '1', 04:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:11 INFO - 'PWD': '/builds/slave/test', 04:07:11 INFO - 'SHELL': '/bin/bash', 04:07:11 INFO - 'SHLVL': '1', 04:07:11 INFO - 'TERM': 'linux', 04:07:11 INFO - 'TMOUT': '86400', 04:07:11 INFO - 'USER': 'cltbld', 04:07:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:11 INFO - '_': '/tools/buildbot/bin/python'} 04:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:11 INFO - Downloading/unpacking psutil>=3.1.1 04: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 04: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 04: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 04: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 04: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 04: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 04:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:13 INFO - Installing collected packages: psutil 04:07:13 INFO - Running setup.py install for psutil 04:07:13 INFO - building 'psutil._psutil_linux' extension 04:07:13 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 04:07:13 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 04:07:13 INFO - building 'psutil._psutil_posix' extension 04:07:13 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 04:07:13 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 04:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:13 INFO - Successfully installed psutil 04:07:13 INFO - Cleaning up... 04:07:13 INFO - Return code: 0 04:07:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:07:13 INFO - Using env: {'DISPLAY': ':0', 04:07:13 INFO - 'HOME': '/home/cltbld', 04:07:13 INFO - 'LANG': 'en_US.UTF-8', 04:07:13 INFO - 'LANGUAGE': 'en_US:en', 04:07:13 INFO - 'LOGNAME': 'cltbld', 04:07:13 INFO - 'MAIL': '/var/mail/cltbld', 04:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:13 INFO - 'MOZ_NO_REMOTE': '1', 04:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:13 INFO - 'NO_EM_RESTART': '1', 04:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:13 INFO - 'PWD': '/builds/slave/test', 04:07:13 INFO - 'SHELL': '/bin/bash', 04:07:13 INFO - 'SHLVL': '1', 04:07:13 INFO - 'TERM': 'linux', 04:07:13 INFO - 'TMOUT': '86400', 04:07:13 INFO - 'USER': 'cltbld', 04:07:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:13 INFO - '_': '/tools/buildbot/bin/python'} 04:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:07:15 INFO - Installing collected packages: mozsystemmonitor 04:07:15 INFO - Running setup.py install for mozsystemmonitor 04:07:16 INFO - Successfully installed mozsystemmonitor 04:07:16 INFO - Cleaning up... 04:07:16 INFO - Return code: 0 04:07:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:07:16 INFO - Using env: {'DISPLAY': ':0', 04:07:16 INFO - 'HOME': '/home/cltbld', 04:07:16 INFO - 'LANG': 'en_US.UTF-8', 04:07:16 INFO - 'LANGUAGE': 'en_US:en', 04:07:16 INFO - 'LOGNAME': 'cltbld', 04:07:16 INFO - 'MAIL': '/var/mail/cltbld', 04:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:16 INFO - 'MOZ_NO_REMOTE': '1', 04:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:16 INFO - 'NO_EM_RESTART': '1', 04:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:16 INFO - 'PWD': '/builds/slave/test', 04:07:16 INFO - 'SHELL': '/bin/bash', 04:07:16 INFO - 'SHLVL': '1', 04:07:16 INFO - 'TERM': 'linux', 04:07:16 INFO - 'TMOUT': '86400', 04:07:16 INFO - 'USER': 'cltbld', 04:07:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:16 INFO - '_': '/tools/buildbot/bin/python'} 04:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:16 INFO - Downloading/unpacking jsonschema==2.5.1 04:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:18 INFO - warning: no files found matching '*.txt' 04:07:18 INFO - no previously-included directories found matching 'build' 04:07:18 INFO - no previously-included directories found matching 'dist' 04:07:18 INFO - no previously-included directories found matching '.git*' 04:07:18 INFO - Installing collected packages: jsonschema, functools32 04:07:18 INFO - Running setup.py install for functools32 04:07:18 INFO - warning: no files found matching '*.txt' 04:07:18 INFO - no previously-included directories found matching 'build' 04:07:18 INFO - no previously-included directories found matching 'dist' 04:07:18 INFO - no previously-included directories found matching '.git*' 04:07:18 INFO - Successfully installed jsonschema functools32 04:07:18 INFO - Cleaning up... 04:07:18 INFO - Return code: 0 04:07:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:18 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 04:07:18 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 04:07:18 INFO - Using env: {'DISPLAY': ':0', 04:07:18 INFO - 'HOME': '/home/cltbld', 04:07:18 INFO - 'LANG': 'en_US.UTF-8', 04:07:18 INFO - 'LANGUAGE': 'en_US:en', 04:07:18 INFO - 'LOGNAME': 'cltbld', 04:07:18 INFO - 'MAIL': '/var/mail/cltbld', 04:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:18 INFO - 'MOZ_NO_REMOTE': '1', 04:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:18 INFO - 'NO_EM_RESTART': '1', 04:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:18 INFO - 'PWD': '/builds/slave/test', 04:07:18 INFO - 'SHELL': '/bin/bash', 04:07:18 INFO - 'SHLVL': '1', 04:07:18 INFO - 'TERM': 'linux', 04:07:18 INFO - 'TMOUT': '86400', 04:07:18 INFO - 'USER': 'cltbld', 04:07:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:18 INFO - '_': '/tools/buildbot/bin/python'} 04:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04: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 04: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 04: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 04: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 04: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 04: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 04:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:21 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 04:07:21 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 04:07:21 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 04:07:21 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 04:07:21 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 04:07:21 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 04:07:21 INFO - Downloading docopt-0.6.1.tar.gz 04:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:21 INFO - Running setup.py install for blobuploader 04:07:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:21 INFO - Running setup.py install for requests 04:07:21 INFO - Running setup.py install for docopt 04:07:22 INFO - Successfully installed blobuploader requests docopt 04:07:22 INFO - Cleaning up... 04:07:22 INFO - Return code: 0 04:07:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:22 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')]} 04:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 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')]} 04:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:22 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 04:07:22 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 04:07:22 INFO - Using env: {'DISPLAY': ':0', 04:07:22 INFO - 'HOME': '/home/cltbld', 04:07:22 INFO - 'LANG': 'en_US.UTF-8', 04:07:22 INFO - 'LANGUAGE': 'en_US:en', 04:07:22 INFO - 'LOGNAME': 'cltbld', 04:07:22 INFO - 'MAIL': '/var/mail/cltbld', 04:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:22 INFO - 'MOZ_NO_REMOTE': '1', 04:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:22 INFO - 'NO_EM_RESTART': '1', 04:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:22 INFO - 'PWD': '/builds/slave/test', 04:07:22 INFO - 'SHELL': '/bin/bash', 04:07:22 INFO - 'SHLVL': '1', 04:07:22 INFO - 'TERM': 'linux', 04:07:22 INFO - 'TMOUT': '86400', 04:07:22 INFO - 'USER': 'cltbld', 04:07:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:22 INFO - '_': '/tools/buildbot/bin/python'} 04:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:22 INFO - Running setup.py (path:/tmp/pip-sCtf4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:22 INFO - Running setup.py (path:/tmp/pip-9zTb5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:22 INFO - Running setup.py (path:/tmp/pip-Ar83_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:22 INFO - Running setup.py (path:/tmp/pip-7PkHBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:22 INFO - Running setup.py (path:/tmp/pip-rCWKoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:22 INFO - Running setup.py (path:/tmp/pip-aJUcDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:22 INFO - Running setup.py (path:/tmp/pip-LuclHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:22 INFO - Running setup.py (path:/tmp/pip-7a9Nih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:22 INFO - Running setup.py (path:/tmp/pip-azuvuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:23 INFO - Running setup.py (path:/tmp/pip-09Zhw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:23 INFO - Running setup.py (path:/tmp/pip-6paQVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:23 INFO - Running setup.py (path:/tmp/pip-UTzJzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:23 INFO - Running setup.py (path:/tmp/pip-ckAGzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:23 INFO - Running setup.py (path:/tmp/pip-K4RQEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:23 INFO - Running setup.py (path:/tmp/pip-CKyjVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:23 INFO - Running setup.py (path:/tmp/pip-Ul4S_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:23 INFO - Running setup.py (path:/tmp/pip-vO98WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:23 INFO - Running setup.py install for manifestparser 04:07:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:23 INFO - Running setup.py install for mozcrash 04:07:23 INFO - Running setup.py install for mozdebug 04:07:23 INFO - Running setup.py install for mozdevice 04:07:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozfile 04:07:24 INFO - Running setup.py install for mozhttpd 04:07:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozinfo 04:07:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozInstall 04:07:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozleak 04:07:24 INFO - Running setup.py install for mozlog 04:07:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for moznetwork 04:07:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozprocess 04:07:24 INFO - Running setup.py install for mozprofile 04:07:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:24 INFO - Running setup.py install for mozrunner 04:07:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:25 INFO - Running setup.py install for mozscreenshot 04:07:25 INFO - Running setup.py install for moztest 04:07:25 INFO - Running setup.py install for mozversion 04:07:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:25 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')]} 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 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')]} 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:25 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 04:07:25 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 04:07:25 INFO - Using env: {'DISPLAY': ':0', 04:07:25 INFO - 'HOME': '/home/cltbld', 04:07:25 INFO - 'LANG': 'en_US.UTF-8', 04:07:25 INFO - 'LANGUAGE': 'en_US:en', 04:07:25 INFO - 'LOGNAME': 'cltbld', 04:07:25 INFO - 'MAIL': '/var/mail/cltbld', 04:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:25 INFO - 'MOZ_NO_REMOTE': '1', 04:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:25 INFO - 'NO_EM_RESTART': '1', 04:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:25 INFO - 'PWD': '/builds/slave/test', 04:07:25 INFO - 'SHELL': '/bin/bash', 04:07:25 INFO - 'SHLVL': '1', 04:07:25 INFO - 'TERM': 'linux', 04:07:25 INFO - 'TMOUT': '86400', 04:07:25 INFO - 'USER': 'cltbld', 04:07:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:25 INFO - '_': '/tools/buildbot/bin/python'} 04:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:25 INFO - Running setup.py (path:/tmp/pip-LXBHed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:25 INFO - Running setup.py (path:/tmp/pip-oG_VxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:25 INFO - Running setup.py (path:/tmp/pip-yaKjQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:25 INFO - Running setup.py (path:/tmp/pip-lLOQ4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:25 INFO - Running setup.py (path:/tmp/pip-j0vGg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:25 INFO - Running setup.py (path:/tmp/pip-BOTiue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:26 INFO - Running setup.py (path:/tmp/pip-eO6S_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:26 INFO - Running setup.py (path:/tmp/pip-nZD1Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:26 INFO - Running setup.py (path:/tmp/pip-Evx6zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:26 INFO - Running setup.py (path:/tmp/pip-Ro2I_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:26 INFO - Running setup.py (path:/tmp/pip-sSapJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:26 INFO - Running setup.py (path:/tmp/pip-zRBnNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:26 INFO - Running setup.py (path:/tmp/pip-TJB9ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:26 INFO - Running setup.py (path:/tmp/pip-4hnFrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:26 INFO - Running setup.py (path:/tmp/pip-bD1R3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:26 INFO - Running setup.py (path:/tmp/pip-Olt5S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:26 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)) 04:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:26 INFO - Running setup.py (path:/tmp/pip-giFXTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:26 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)) 04:07:26 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)) 04:07:26 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)) 04:07:26 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)) 04:07:26 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)) 04:07:26 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)) 04:07:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:28 INFO - Downloading blessings-1.6.tar.gz 04:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:28 INFO - Installing collected packages: blessings 04:07:28 INFO - Running setup.py install for blessings 04:07:28 INFO - Successfully installed blessings 04:07:28 INFO - Cleaning up... 04:07:28 INFO - Return code: 0 04:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:29 INFO - Reading from file tmpfile_stdout 04:07:29 INFO - Current package versions: 04:07:29 INFO - argparse == 1.2.1 04:07:29 INFO - blessings == 1.6 04:07:29 INFO - blobuploader == 1.2.4 04:07:29 INFO - docopt == 0.6.1 04:07:29 INFO - functools32 == 3.2.3-2 04:07:29 INFO - jsonschema == 2.5.1 04:07:29 INFO - manifestparser == 1.1 04:07:29 INFO - mozInstall == 1.12 04:07:29 INFO - mozcrash == 0.17 04:07:29 INFO - mozdebug == 0.1 04:07:29 INFO - mozdevice == 0.48 04:07:29 INFO - mozfile == 1.2 04:07:29 INFO - mozhttpd == 0.7 04:07:29 INFO - mozinfo == 0.9 04:07:29 INFO - mozleak == 0.1 04:07:29 INFO - mozlog == 3.3 04:07:29 INFO - moznetwork == 0.27 04:07:29 INFO - mozprocess == 0.23 04:07:29 INFO - mozprofile == 0.28 04:07:29 INFO - mozrunner == 6.12 04:07:29 INFO - mozscreenshot == 0.1 04:07:29 INFO - mozsystemmonitor == 0.3 04:07:29 INFO - moztest == 0.7 04:07:29 INFO - mozversion == 1.4 04:07:29 INFO - psutil == 3.1.1 04:07:29 INFO - requests == 1.2.3 04:07:29 INFO - wsgiref == 0.1.2 04:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:29 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')]} 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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')]} 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:29 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 04:07:29 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 04:07:29 INFO - Using env: {'DISPLAY': ':0', 04:07:29 INFO - 'HOME': '/home/cltbld', 04:07:29 INFO - 'LANG': 'en_US.UTF-8', 04:07:29 INFO - 'LANGUAGE': 'en_US:en', 04:07:29 INFO - 'LOGNAME': 'cltbld', 04:07:29 INFO - 'MAIL': '/var/mail/cltbld', 04:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:29 INFO - 'MOZ_NO_REMOTE': '1', 04:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:29 INFO - 'NO_EM_RESTART': '1', 04:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:29 INFO - 'PWD': '/builds/slave/test', 04:07:29 INFO - 'SHELL': '/bin/bash', 04:07:29 INFO - 'SHLVL': '1', 04:07:29 INFO - 'TERM': 'linux', 04:07:29 INFO - 'TMOUT': '86400', 04:07:29 INFO - 'USER': 'cltbld', 04:07:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:29 INFO - '_': '/tools/buildbot/bin/python'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 INFO - Cleaning up... 04:07:29 INFO - Return code: 0 04:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:29 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')]} 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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')]} 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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 0x1866030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, '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': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', '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 04:07:29 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 04:07:29 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 04:07:29 INFO - Using env: {'DISPLAY': ':0', 04:07:29 INFO - 'HOME': '/home/cltbld', 04:07:29 INFO - 'LANG': 'en_US.UTF-8', 04:07:29 INFO - 'LANGUAGE': 'en_US:en', 04:07:29 INFO - 'LOGNAME': 'cltbld', 04:07:29 INFO - 'MAIL': '/var/mail/cltbld', 04:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:29 INFO - 'MOZ_NO_REMOTE': '1', 04:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:29 INFO - 'NO_EM_RESTART': '1', 04:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:29 INFO - 'PWD': '/builds/slave/test', 04:07:29 INFO - 'SHELL': '/bin/bash', 04:07:29 INFO - 'SHLVL': '1', 04:07:29 INFO - 'TERM': 'linux', 04:07:29 INFO - 'TMOUT': '86400', 04:07:29 INFO - 'USER': 'cltbld', 04:07:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:29 INFO - '_': '/tools/buildbot/bin/python'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:29 INFO - Cleaning up... 04:07:29 INFO - Return code: 0 04:07:29 INFO - Running post-action listener: _resource_record_post_action 04:07:29 INFO - Running post-action listener: _start_resource_monitoring 04:07:29 INFO - Starting resource monitoring. 04:07:29 INFO - [mozharness: 2016-07-21 11:07:29.654989Z] Finished create-virtualenv step (success) 04:07:29 INFO - [mozharness: 2016-07-21 11:07:29.655466Z] Running install step. 04:07:29 INFO - Running pre-action listener: _resource_record_pre_action 04:07:29 INFO - Running main action method: install 04:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:29 INFO - Reading from file tmpfile_stdout 04:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:29 INFO - Reading from file tmpfile_stdout 04:07:29 INFO - Output received: 04:07:29 INFO - Usage: mozinstall [options] installer 04:07:29 INFO - Options: 04:07:29 INFO - -h, --help show this help message and exit 04:07:29 INFO - -d DEST, --destination=DEST 04:07:29 INFO - Directory to install application into. [default: 04:07:29 INFO - "/builds/slave/test"] 04:07:29 INFO - --app=APP Application being installed. [default: firefox] 04:07:29 INFO - mkdir: /builds/slave/test/build/application 04:07:29 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'] 04:07:29 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 04:07:46 INFO - Reading from file tmpfile_stdout 04:07:46 INFO - Output received: 04:07:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:46 INFO - Running post-action listener: _resource_record_post_action 04:07:46 INFO - [mozharness: 2016-07-21 11:07:46.335672Z] Finished install step (success) 04:07:46 INFO - [mozharness: 2016-07-21 11:07:46.335950Z] Running run-tests step. 04:07:46 INFO - Running pre-action listener: _resource_record_pre_action 04:07:46 INFO - Running main action method: run_tests 04:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:46 INFO - Python 2.7.3 04:07:46 INFO - Return code: 0 04:07:46 INFO - grabbing minidump binary from tooltool 04:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:46 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 0x1b24570>, '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 0x1b25470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:46 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 04:07:46 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 04:07:46 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 04:07:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:46 INFO - Return code: 0 04:07:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:07:46 INFO - Using env: {'DISPLAY': ':0', 04:07:46 INFO - 'HOME': '/home/cltbld', 04:07:46 INFO - 'LANG': 'en_US.UTF-8', 04:07:46 INFO - 'LANGUAGE': 'en_US:en', 04:07:46 INFO - 'LOGNAME': 'cltbld', 04:07:46 INFO - 'MAIL': '/var/mail/cltbld', 04:07:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:46 INFO - 'MOZ_NO_REMOTE': '1', 04:07:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:46 INFO - 'NO_EM_RESTART': '1', 04:07:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:46 INFO - 'PWD': '/builds/slave/test', 04:07:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:46 INFO - 'SHELL': '/bin/bash', 04:07:46 INFO - 'SHLVL': '1', 04:07:46 INFO - 'TERM': 'linux', 04:07:46 INFO - 'TMOUT': '86400', 04:07:46 INFO - 'USER': 'cltbld', 04:07:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418', 04:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:46 INFO - '_': '/tools/buildbot/bin/python'} 04:07:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:07:46 INFO - mozversion application_buildid: 20160721025319 04:07:46 INFO - mozversion application_changeset: 29ead859749af91a4e70d10a278a0ca3fca9d2b4 04:07:46 INFO - mozversion application_display_name: Nightly 04:07:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:46 INFO - mozversion application_name: Firefox 04:07:46 INFO - mozversion application_remotingname: firefox 04:07:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:07:46 INFO - mozversion application_vendor: Mozilla 04:07:46 INFO - mozversion application_version: 50.0a1 04:07:46 INFO - mozversion platform_buildid: 20160721025319 04:07:46 INFO - mozversion platform_changeset: 29ead859749af91a4e70d10a278a0ca3fca9d2b4 04:07:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:07:46 INFO - mozversion platform_version: 50.0a1 04:07:46 INFO - using testdate: 1469099266 04:07:46 INFO - actual date: 1469099266 04:07:46 INFO - starting webserver on 'localhost:59533' 04:07:46 INFO - SUITE-START | Running 2 tests 04:07:46 INFO - TEST-START | dromaeo_css 04:07:46 INFO - operating with platform_type : linux_ 04:07:46 INFO - Initialising browser for dromaeo_css test... 04:07:46 INFO - TEST-INFO | started process 6464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGb4VAC/profile http://localhost:59533/getInfo.html) 04:07:51 INFO - PROCESS | 6464 | __metrics Screen width/height:1600/1200 04:07:51 INFO - PROCESS | 6464 | colorDepth:24 04:07:51 INFO - PROCESS | 6464 | Browser inner width/height: 1024/697 04:07:51 INFO - PROCESS | 6464 | __metrics 04:07:51 ERROR - PROCESS | 6464 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:07:52 INFO - TEST-INFO | 6464: exit 0 04:07:52 INFO - Browser initialized. 04:07:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:52 INFO - TEST-INFO | started process 6584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGb4VAC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:04 INFO - PROCESS | 6584 | RSS: Main: 168632320 04:08:04 INFO - PROCESS | 6584 | 04:08:54 INFO - PROCESS | 6584 | 1469099334179 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] 04:11:07 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59533/tests/dromaeo/cssquery-ext.html) 04:11:08 INFO - PROCESS | 6584 | RSS: Main: 169828352 04:11:08 INFO - PROCESS | 6584 | 04:14:10 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-ext.html (next: http://localhost:59533/tests/dromaeo/cssquery-jquery.html) 04:14:11 INFO - PROCESS | 6584 | RSS: Main: 170274816 04:14:11 INFO - PROCESS | 6584 | 04:17:13 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59533/tests/dromaeo/cssquery-mootools.html) 04:17:13 INFO - PROCESS | 6584 | RSS: Main: 173277184 04:17:13 INFO - PROCESS | 6584 | 04:20:15 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59533/tests/dromaeo/cssquery-prototype.html) 04:20:16 INFO - PROCESS | 6584 | RSS: Main: 167559168 04:20:16 INFO - PROCESS | 6584 | 04:23:19 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59533/tests/dromaeo/cssquery-yui.html) 04:23:19 INFO - PROCESS | 6584 | RSS: Main: 169607168 04:23:19 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-yui.html (next: http://localhost:59533/tests/dromaeo/cssquery-dojo.html) 04:26:22 INFO - PROCESS | 6584 | RSS: Main: 171036672 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | __start_tp_report 04:26:22 INFO - PROCESS | 6584 | _x_x_mozilla_page_load 04:26:22 INFO - PROCESS | 6584 | _x_x_mozilla_page_load_details 04:26:22 INFO - PROCESS | 6584 | |i|pagename|runs| 04:26:22 INFO - PROCESS | 6584 | |0;dojo.html;2619.030958545338;2622.5017246723123;2642.907498237562;2648.655674762281;2668.332916770806;4721.10299043182;4787.042591481701;4824.276358546211;4838.129136755382;4875.293082503039;4633.073385322932;4762.380890484233;4767.6185905127595;4777.713337199771;4854.951450485494;4391.429114215155;4414.183376075421;4460.174867649495;4486.439195100613;4518.412606361185;4382.649388048964;4472.08322293929;4515.61617262533;4546.204414227514;4571.839985600504;4289.549597292271;4336.609705126522;4361.738295702268;4376.5623437656295;4422.579854913778;4419;4436.600705936449;4439.178751930903;4461.486929003141;4471.262241730111;4384.4081049058605;4404.779761011969;4426.22541055314;4429.800658970354;4462.419885414908;4649.744264065475;4690.812367505296;4714.599259062984;4761.976190119062;4821.083994041121;5019.322391477141;5053.620978426633;5055.469175736532;5087.542121209072;5097.694138351673;5077.365329333833;5101.821436249714;5106.591472682177;5108.2848401223855;5154.020736060136;4640.767961601974;4679.298105284234;4697.4832768395445;4733.029728905635;4735.147673418817;5161.4322424533275;5164.715940623227;5165.845024649267;5182.119039763249;5203.583713303003;4944.332515110486;4966.180580204298;4977.90044199114;5002.299678045004;5018.447970723218;4975.0796102721115;5055.9241611375855;5062.341895553554;5073.086844368049;5095.0828850806465;5033.446320904697;5042.773075211624;5048.848534543969;5069.670471419346;5075.8984820303385;5030.220315851049;5056.165732654144;5071.4928507149725;5075.974620126875;5092.541671249605;4208.642265407413;4238.597333253336;4291.463567054118;4301.268784306675;4328.740275583412;3783;3786.053486628343;3786.413105968579;3792.1467669774634;3822.7515211511163;4450.443694538183;4511.233090374644;4523.954760452353;4579.290210017452;4594.379758732528;5022.472640372781;5023.79904803811;5073.949260507421;5078.111330517218;5175.585953123741;4414.668899832525;4466.173757854807;4472.485664148665;4480.932786008212;4485.394471746273;4297.957020429756;4307.655387568987;4324.8486302979245;4351.042770590465;4351.8476853309985;4725.669203155746;4816.735079570727;4882.658213924991;4925.729084900365;4930.704157750403;5200.089984252816;5208.9739551302;5213.035588416155;5231.29377534028;5245.475452454724;4883.291922671122;4901.460839307744;4903.362562866804;4904.558589726942;4908.435529914105;4928.334674818853;4940.975295123501;4946.653734238569;4968.577670897869;5120.846374608767;5025.623078269071;5025.974870125626;5028.974855125847;5045.672031317952;5056.393232811939;4904.288878112725;4909.950900491092;4910.337104490991;4914.533119353656;4951.034548263054;4860.198067318853;4941.50584941503;4951.183054795918;4973.35346404965;5011.924821127759;4841.685290456109;4852.1508735971765;4948.15881300187;4952.059108769322;4969.130402179532;5055.747212639427;5063.0380227756605;5069.214271787879;5069.7465126744255;5102.6938383695615;4745.952540474551;4831;4877.561019508261;4942.357493525818;5002.199648056294 04:26:22 INFO - PROCESS | 6584 | |1;ext.html;557.5985290590774;560.2548610348236;568.7525926222094;579.9391063938286;603.2188316130611;36487.81756091219;40355.798221008925;40358.59641403585;40413.19173616526;40421.393679094836;40284;40738;40817;40891.59108408915;40891.79554102226;7796.766097017098;7867.095284042322;7886.408519361043;7936;7945;7782.299593036626;7788.026496687914;7790.493617914845;7843.058832940055;7871.763847084568;7853.489523181003;7878.1334053254095;7880.5271683698875;7885.053793544783;7894.60526973649;7843.450958432912;7860.882086768703;7880.408969327266;7888.684452621888;7906.090799558038;7695.807604809868;7808.063032436087;7830.138684744674;7833.529988200727;7848.843023139505;37509.81245093785;38029.80985095084;38128.618713812786;38161;38261.61738382608;2542.6186072089336;2818.3799564095866;2858.771298296131;3045.9847700761575;3136.498160294342;27770.444591108266;27811.86094069537;28319.29201769972;28448.28879278014;28919.26484410921;3337.7830441021497;3374.578177727784;3384.086296699902;3481.251530920839;3519.718422526217;261579;261713;266213;266607;267992;54322;54501.1824822628;54971.175432368545;54996.725016374665;55143.72428137914;32969.17577060593;34039.489407658904;34443.4833477498;36006.63993360033;57555.424445755845;14855.48005819791;15043.097414155185;15056.247187640793;15059.774103388458;15061.472848450252;11277.661670149908;11381.658550243506;11393.430328483542;11406.714832129097;11429.942850285695;18564;18595.721064184047;18632.347867824563;18632.44102676922;18770.81229187718;6873.759418420432;6911.827204319932;7166.713331466683;7214.531055481377;7249.275072492814;778.6029125146104;797.9760607181794;883.902770695223;899.1907283444951;976.4531862157214;25825;29067.41865162685;29325.85337073301;29440.852795735886;29670.55494167589;920.0540856089457;937.2080591899834;986.1666891476691;1012.0126700798829;1017.2878984710732;13993.930030349784;14023.368948397347;14277.857221427652;14630.195339256443;14769.113853168845;400273;402365;403134;404403;406398;48356.27465588019;48606.51393486091;48608.78478038007;48703;48762.75618621955;1197.4072833947253;1218.1838168427175;1251.7997120460682;1252.555342853274;1260.9117361784588;25571.48857022812;26713.599296010965;26908.501894753557;27518.312042199104;27762.44475110446;42043.57956420519;42301.153976920905;42502.149957001304;42606.786966064974;42612.36081458843;372032;375516;375679;375729;376909;38295.42556861705;38890.6110938887;38929.41605875971;38996.805015974736;39103.608963909996;42025;42302.153956920076;42654.78672606617;43250.567494324656;43762;35915.820420897726;36258;36380.454293185096;36574;36598.451023235204;36200.45699314565;36360.27279454449;36685.26629467449;36727;37324;32106.19734506656;36232.27535449224;36410;36923;37471.43792843164;28134.577981329887;30598.694013059583;30709.69290307068;31170.844145780033;31208.53187202239;25066.122685705912;25083.749162508142;25375.492490150464;25652.35869103213;25705.485890282464 04:26:22 INFO - PROCESS | 6584 | |2;jquery.html;358.90489020409586;359.55774397491103;366.2418793098287;370.9814509274536;383.1799948111043;16028.919855400736;16788.664226715457;17087.48737537873;17215.655686886254;17267.654646907053;16415.753763693556;16784.412545560906;17183.140842957833;17342.739858902096;17392.739108913345;4999.050180465709;5238.790448382079;5243.764030618631;5244;5246.029484545371;3807.143392736626;5186.196139598368;5737.856553586173;5991.221141251631;6013.917494850925;6065.757369705207;6077.209962704865;6085.604435711687;6091.390860913917;6095.512359011268;5111.744412779365;5327.094393953037;5366.06093933562;5461.317335333083;5462.371827239878;5150.253213284052;5284.656497327662;5316.627836051478;5320.787168513255;5341.092014357569;12275.631731048083;12500;12516.311602861839;12675.239485630891;12676.23942563449;1717.2959086774488;1891.4514790710678;1937.6705959986837;2008.5079155606825;2387.806096951524;9254.148454243905;9408.576614052316;9439.622415103388;9483.857742133874;9620.278479114024;1607.23656263274;1664.7752553405257;1726.3526177683368;1731.7662115614482;1778.9911050444664;67352.32647673509;72103.63948180278;72427;72477.63761181213;73396.89904651488;9995.200383969264;10127.64553240633;10154.593816247267;10160.33957792741;10309.278350515391;13551;13595.116317439533;13609.387577559033;13715.725685486434;13721.931390343185;6990.26602206761;7157.2127066022695;7196.568205907663;7282.162551306562;7394.149672787698;6917.757878474229;6922.238553759083;7043.7534686285735;7112.288771122846;7174.31843974832;4174.102567947906;4186.853460128881;4249.917540405179;4305.612494875413;4396.758178300161;1515.454436402894;1550.317860141534;1580.8023997000375;1796.1468302556182;1888.1975160556983;839.0686338164633;851.7657644147909;901.0403919825364;913.456493386434;963.2919803944095;16314.428994985119;16876.746848797276;17122.40071597488;17349.826501735075;17649.294028238983;816.7223144130905;818.9549574773325;864.6887120636566;867.7266661001764;907.5144797533288;9133.415223679554;9722.416655000723;9727.270454715925;9804.166645835041;9885.110340069428;382515;384861;408025;411199;411949;75454;78898.60550697324;79942.60028699819;80451.59774201091;82426;885.964561417549;891.0955380288882;917.1516347378648;921.1341339141186;921.6912334367928;15085.849141508445;15259.465918692793;15804.68390632204;15853.52439426819;15958.920205399363;27165;27261.045863394687;27612.447751045267;35292.11786703512;36954;49494.50505494899;49857.252141217185;50474.242886356;50651;52519.73740131275;7020.543664661985;7069.858602828018;7070.7525236616475;7075.893861592183;7240.312170343809;9453.669121580986;11422.714432139262;11426.600068997877;11526.481308340977;11670.94164529172;9980.201583873128;10309.22680798958;10416.947915260678;10759.30064545802;10847.674569762605;9854.605815767576;10298.794024119625;10449.738756531147;10462.895371046496;10535.57857685684;9573.18627916635;10183.388996660224;10422.478876056319;10626.574937002433;10670.19973502006;6756.493263005196;6880.208775990825;6952.791416257521;6997.965010174917;7267.127944646676;8056.355491560544;9463.195628371666;9518.476483793458;9622.807543849223;9757.51212439361 04:26:22 INFO - PROCESS | 6584 | |3;mootools.html;1371.5542448704168;1422.2959634980684;1511.3047997920962;1684.7388654758502;1723.5518765121064;6751.662416879149;7651.732189373359;7665.961670191648;8145.91854081459;8154.8369032619385;7750.806229844243;8012;8023.197680231974;8026.678932842679;8040.517568945853;2202.8568143070647;2230.308604332654;2233.8771367574777;2237.552489502098;2237.85453945493;2146.6887301341294;2148.79586439288;2203.2839327218717;2214.6677998300224;2230.643097104464;2153.7630860605323;2165.372042107787;2180.7274090738656;2182.225310014938;2220.367195349326;2064.267185149273;2071.420002399323;2075.190675636503;2080.9479763005893;2089.696993935871;2134.455713792973;2163.9783602163934;2170.218721260345;2191.9697742061207;2198.5492973940304;7868.527888326662;7920.64357103926;7926.445148839583;7928.524288542706;7939.523628582304;4550.954490455086;4697.553732395417;4717.103750287434;4732.881677958044;4734.810607575693;2721.9047333343437;2814.0994881637885;2818.3236023354452;2854.728800763924;2890.609767681357;927.8097989912052;954.9809003819885;958.7603099225194;994.602159136344;995.8605795188679;10826.404547749871;10833.133349332113;10849.566017359297;10860.67417977462;10879.673609791718;3927.4108883667677;4085.611866872642;4227.070044590185;4243.830246790156;4247.17180149874;9223.49270790113;9285.767855803659;9299.581518831668;9312.580933857993;9326.580303886341;4539.6368290536675;4550.863474095716;4670.182718024332;4683.648726345537;4688.132695451352;3702.777833330009;4135.17296540693;4237.8304867805555;4246.893827654333;4264.275073237557;3512.8067956262653;3590.4202151053455;3687.4284485904727;3707.0547010512146;3799.848006079726;1131.3833960491552;1168.8129899216085;1186.1163433242118;1189.3339729751367;1194.635636130971;780.282140430805;793.262266092528;801.3308887079238;828;838.4927119092982;4977.104121258209;5046.823361182341;5129.769160387791;5194.662346947436;5288.524032836986;404.3429427180831;418.30561268294485;421.58473903205316;421.711127877405;429.37311525173595;3327.9500807487907;3330.4837750148768;3356.2112903467664;3373.1904342958005;3427.9828600857336;9629.951850240845;9924.900750992398;10029.498525073717;10033.849492257623;10068.295219334575;10009.24930630191;10021.599136034623;10030.247731420173;10046.899531004596;10073.848892266622;7373.410127189812;7468.925310746823;7528.623568821647;7603.581803000888;7668.961655191688;5060;5097.209932460474;5125.308083408841;5149.459306772735;5220.686758794484;8951.149640784115;9097.1812536872;9139.086091391073;9149.862752058858;9245.61315802635;9231.123043310874;9267.6292948284;9357.672481463116;9359.110884465965;9363.110504502061;5967.37342579023;6593.406593406617;6750.966245168743;6898.724051037902;6964.164300283998;7587.924120758722;7634.732784352521;7666.233376662289;7699.576523291273;7703.268189521987;6654.866902662016;6745.156855393076;6809.625470599165;6829.795106146824;6873.725050998104;6663.7001334941015;6733.764318248838;6741.460683145238;6883.380495755406;6931.653417329013;6067.514598832171;6266.561340706289;6317.715702793477;6330.620162790247;6334.239891213084;4281.700280980302;4381.342798580238;4484;4492.775361231991;4554.635629149726;4534.7052441591195;4654.93017604743;4672.556107169813;4692.50728673498;4786.473487916396 04:26:22 INFO - PROCESS | 6584 | |4;prototype.html;295.74565873348917;298.46872566831036;307.86300096457086;310.72500836759474;314.1157641239911;4906.705597664142;4966.925496117561;5132.563732082773;5185.170372740362;5194.844154675366;4971.154903666376;5018.473060328659;5059.747012649362;5064.873378165547;5087.872803179922;3986.6013398660193;3995.8002099895034;4005.2390045891334;4025.134596061846;4033.2740106780766;3936.5079365079364;3998.2003599280115;4010.1979604079156;4039.2123535910364;4040.1919616076757;3941.901452463697;3951.308521008826;3958.5447673517483;3960.4059391091423;3986.70099742519;3941.8226179821977;3961;3975.721699481023;3986.64787775214;3994.7802870842092;3508.5088087667746;3511.227529943408;3518.6833185013215;3524.2246705724956;3545.0782796472845;4936.259561065869;5005.072032860744;5006.199008158677;5027.296178535008;5087.9061001884775;4512.909741805179;4513.210188217049;4560.612347950429;4565.488981060436;4565.5206203348835;5333.173358129496;5334.946650533522;5368.4363141869935;5387.0841956867425;5390.97304513475;3714.665680088778;3794.6015668354976;3803.7717736935874;3813.466114743938;3843.1552854629654;5561.499465048165;5594.216809646653;5611.775528978836;5654.123610840285;5664.40523745005;3941.921161576752;3948.4137889682306;3957.7730903420033;3959.8020098994934;3971.3050216212046;3880.262750077476;3970.7021973352116;4012.8996775080273;4015.2772500949527;4032.689375952827;4516.16450956574;4535.433070866142;4539.341795439643;4541.6593755468475;4542.250528662734;5383.946160538423;5386.703731294738;5387.3804512481565;5416.729163541807;5425.565954723613;1315.2043013976597;1338.2773302416585;1371.4719832864419;1388.9166650001032;1406.8944829137856;942.260737989615;945.8533927241289;949.4920217683506;969.5879251318162;974.2741657465234;4662.650301227422;4677.18149323867;4704.29435584665;4708.4820669726305;4711.528847115261;5413.2150838128255;5417.241586177859;5419.729013549386;5421.945780542223;5453.291072160594;4541.5231400703115;4665.250531050856;4678.672492925531;4704.223803072455;4712.88217794551;2913.592097106407;2952.9664617384174;2953.7636989040825;2959.77801664876;2960.851957402121;5225.843224703265;5244.423113457593;5247.317848679647;5266.78863861314;5273.630845840754;5334.839954801362;5608.887822243532;5664.5751568631695;5682.602217844711;5687.402822703557;5172.120739474299;5216.191490318931;5245.6852588844795;5249.895002099936;5255.527002569787;5508.724563771875;5575.717584955401;5594.4125866785025;5594.608377413542;5598.720063996702;5243.475652434726;5414.756335964812;5418.593605479526;5452.073147565003;5472.261244731911;5190.97404512975;5219.8434046978655;5237.250443517184;5241;5270.077736396192;3979.42298366741;4007.5391329997424;4047.2310261050307;4050.8784736457956;4053.5946405359227;5245.554127899019;5257.447967963309;5520.475554822286;5522.668639881459;5552.250446189712;5219.634625576326;5363.5440987516495;5389.946100538945;5396;5401.2168235606405;5348.946510535001;5357.142857142839;5359.169328754049;5379.408265090915;5405.8107966221;5102.311187989574;5212.8010557571215;5261.710605916558;5271.499207575274;5306.495882891119;5358.981793459387;5365.865853353697;5390.730463476732;5408.810691625774;5421;5261.605379596469;5285.762140703754;5291.259223708761;5302.867428314169;5331 04:26:22 INFO - PROCESS | 6584 | |5;yui.html;641.5220660607848;730.4266151071413;738.6048464071723;742.9702811887523;745.7911784700283;12779.936100319497;13733.93133034336;13795.379207935643;13803.930980345109;13930.582082537527;12725.936370318159;13131.21212727237;13237.073404861663;13269.734605307887;13355.265460399698;751.9774406767806;771.0824119298045;776.9028871391076;778.7313376884965;779.1935346915943;622.1600838867538;772.2277722277722;789.3685051958439;793.892824468698;798.5887268056955;827.0323721246157;830.5888585150359;834.6202477872554;836.4646626159263;840.0801122770556;828.3745771942175;829.4857188543111;829.6515463505312;830.9169083091703;831.4470876866876;605.1799811255729;606.2906399512536;607.7083000159904;608.6986941464004;611.5046812082228;13399.464021439131;13492.662683432894;13492.932535337359;13514.391852366569;13538.864611353858;13236.536721214807;13287.534936277281;13377.933110334387;13567.389467473988;13691.178529288274;10261.948690256575;10667.626633067805;10695.411752353617;10769.207747444903;10978.560857565768;3259.837008149583;3291.769576129672;3303.801771893694;3350.731941444703;3354.1782263345635;61413;62855.68572157156;63547.04679429812;63946.3605363945;65135;10045.19638428924;10194.388336699822;10225.744356391;10278.280520363653;10460.895391045991;17001.40495082691;17760.555986100193;19784.604307914047;19993.300234491722;20199;6878.55289406187;6909.654517274116;7150;7160.820979475555;7187.1375434947095;3775.433684947225;3775.4336849472797;3865.4588357629955;3898.2788184186015;3899.951287888565;2808.3119635689386;2881.207667891347;2889.8555072246304;2907.3749143934156;2917.3581812001325;510.6680657572533;519.1019536202391;523.5445162708468;527.0302643136647;527.211818331589;497.7710253283458;544.5616278895448;554.3790954131399;555.7693557173727;558.6899270904687;8099.514029158269;8247.381446391424;8430.704925327584;8447.197516235949;8995.28037756978;554.7559074007423;576.6741790888135;595.3629616310593;604.4710877981765;606.7057477123592;3598.172420343283;3724.776513409204;3833.597472265372;3977.3437382831507;3982;65246.673766631815;91907;93527;94017;95080;49679.50320496821;52539;83827.58086209653;83899.5805020971;84954.5752271247;63579;75533.24466755372;76123;76570.61714691503;77030.2296977023;7178.0808257087;7192.892106618509;7246.927530724625;7341;7400.629968501661;44673.10653786841;45478;45846;47281.76359118182;47520.7623961878;58765;60010.69994649999;64874.35125648872;65949;66620.33379666142;9097.1812536872;9255.167034966886;9281.39670921388;9314.580843861906;9431.62273509052;10699.732331908534;10888.94555527249;11061.5022323994;11104.389258590854;11109.888901110886;10347.068763811292;10589.947050265007;10687.679369618923;10837.620683276047;10872.238943273895;10327.070563649308;10385.273030888067;10499.842502362624;10625.149988000787;10660.413677247825;10048.547815348473;10159.390436573829;10209.234307426825;10613.893861061599;10645.041946224877;8285.295749861329;8595.742127736177;8681.262092722189;8780.121987801169;8856.202941735275;8772.649094036422;9329;9345.672901448417;9345.906540934775;9379.859302110337 04:26:22 INFO - PROCESS | 6584 | __end_tp_report 04:26:22 INFO - PROCESS | 6584 | __start_cc_report 04:26:22 INFO - PROCESS | 6584 | _x_x_mozilla_cycle_collect,388 04:26:22 INFO - PROCESS | 6584 | __end_cc_report 04:26:22 INFO - PROCESS | 6584 | __startTimestamp1469100382715__endTimestamp 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | ------- Summary: start ------- 04:26:22 INFO - PROCESS | 6584 | Number of tests: 6 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#0] dojo.html Cycles:165 Average:4712.13 Median:4877.56 stddev:490.22 (10.1%) stddev-sans-first:463.40 04:26:22 INFO - PROCESS | 6584 | Values: 2619.0 2622.5 2642.9 2648.7 2668.3 4721.1 4787.0 4824.3 4838.1 4875.3 4633.1 4762.4 4767.6 4777.7 4855.0 4391.4 4414.2 4460.2 4486.4 4518.4 4382.6 4472.1 4515.6 4546.2 4571.8 4289.5 4336.6 4361.7 4376.6 4422.6 4419.0 4436.6 4439.2 4461.5 4471.3 4384.4 4404.8 4426.2 4429.8 4462.4 4649.7 4690.8 4714.6 4762.0 4821.1 5019.3 5053.6 5055.5 5087.5 5097.7 5077.4 5101.8 5106.6 5108.3 5154.0 4640.8 4679.3 4697.5 4733.0 4735.1 5161.4 5164.7 5165.8 5182.1 5203.6 4944.3 4966.2 4977.9 5002.3 5018.4 4975.1 5055.9 5062.3 5073.1 5095.1 5033.4 5042.8 5048.8 5069.7 5075.9 5030.2 5056.2 5071.5 5076.0 5092.5 4208.6 4238.6 4291.5 4301.3 4328.7 3783.0 3786.1 3786.4 3792.1 3822.8 4450.4 4511.2 4524.0 4579.3 4594.4 5022.5 5023.8 5073.9 5078.1 5175.6 4414.7 4466.2 4472.5 4480.9 4485.4 4298.0 4307.7 4324.8 4351.0 4351.8 4725.7 4816.7 4882.7 4925.7 4930.7 5200.1 5209.0 5213.0 5231.3 5245.5 4883.3 4901.5 4903.4 4904.6 4908.4 4928.3 4941.0 4946.7 4968.6 5120.8 5025.6 5026.0 5029.0 5045.7 5056.4 4904.3 4910.0 4910.3 4914.5 4951.0 4860.2 4941.5 4951.2 4973.4 5011.9 4841.7 4852.2 4948.2 4952.1 4969.1 5055.7 5063.0 5069.2 5069.7 5102.7 4746.0 4831.0 4877.6 4942.4 5002.2 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#1] ext.html Cycles:180 Average:49782.36 Median:375704.00 stddev:93098.00 (24.8%) stddev-sans-first:93285.80 04:26:22 INFO - PROCESS | 6584 | Values: 557.6 560.3 568.8 579.9 603.2 36487.8 40355.8 40358.6 40413.2 40421.4 40284.0 40738.0 40817.0 40891.6 40891.8 7796.8 7867.1 7886.4 7936.0 7945.0 7782.3 7788.0 7790.5 7843.1 7871.8 7853.5 7878.1 7880.5 7885.1 7894.6 7843.5 7860.9 7880.4 7888.7 7906.1 7695.8 7808.1 7830.1 7833.5 7848.8 37509.8 38029.8 38128.6 38161.0 38261.6 2542.6 2818.4 2858.8 3046.0 3136.5 27770.4 27811.9 28319.3 28448.3 28919.3 3337.8 3374.6 3384.1 3481.3 3519.7 261579.0 261713.0 266213.0 266607.0 267992.0 54322.0 54501.2 54971.2 54996.7 55143.7 32969.2 34039.5 34443.5 36006.6 57555.4 14855.5 15043.1 15056.2 15059.8 15061.5 11277.7 11381.7 11393.4 11406.7 11429.9 18564.0 18595.7 18632.3 18632.4 18770.8 6873.8 6911.8 7166.7 7214.5 7249.3 778.6 798.0 883.9 899.2 976.5 25825.0 29067.4 29325.9 29440.9 29670.6 920.1 937.2 986.2 1012.0 1017.3 13993.9 14023.4 14277.9 14630.2 14769.1 400273.0 402365.0 403134.0 404403.0 406398.0 48356.3 48606.5 48608.8 48703.0 48762.8 1197.4 1218.2 1251.8 1252.6 1260.9 25571.5 26713.6 26908.5 27518.3 27762.4 42043.6 42301.2 42502.1 42606.8 42612.4 372032.0 375516.0 375679.0 375729.0 376909.0 38295.4 38890.6 38929.4 38996.8 39103.6 42025.0 42302.2 42654.8 43250.6 43762.0 35915.8 36258.0 36380.5 36574.0 36598.5 36200.5 36360.3 36685.3 36727.0 37324.0 32106.2 36232.3 36410.0 36923.0 37471.4 28134.6 30598.7 30709.7 31170.8 31208.5 25066.1 25083.7 25375.5 25652.4 25705.5 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#2] jquery.html Cycles:180 Average:24271.77 Median:27881.37 stddev:66086.97 (237.0%) stddev-sans-first:66247.97 04:26:22 INFO - PROCESS | 6584 | Values: 358.9 359.6 366.2 371.0 383.2 16028.9 16788.7 17087.5 17215.7 17267.7 16415.8 16784.4 17183.1 17342.7 17392.7 4999.1 5238.8 5243.8 5244.0 5246.0 3807.1 5186.2 5737.9 5991.2 6013.9 6065.8 6077.2 6085.6 6091.4 6095.5 5111.7 5327.1 5366.1 5461.3 5462.4 5150.3 5284.7 5316.6 5320.8 5341.1 12275.6 12500.0 12516.3 12675.2 12676.2 1717.3 1891.5 1937.7 2008.5 2387.8 9254.1 9408.6 9439.6 9483.9 9620.3 1607.2 1664.8 1726.4 1731.8 1779.0 67352.3 72103.6 72427.0 72477.6 73396.9 9995.2 10127.6 10154.6 10160.3 10309.3 13551.0 13595.1 13609.4 13715.7 13721.9 6990.3 7157.2 7196.6 7282.2 7394.1 6917.8 6922.2 7043.8 7112.3 7174.3 4174.1 4186.9 4249.9 4305.6 4396.8 1515.5 1550.3 1580.8 1796.1 1888.2 839.1 851.8 901.0 913.5 963.3 16314.4 16876.7 17122.4 17349.8 17649.3 816.7 819.0 864.7 867.7 907.5 9133.4 9722.4 9727.3 9804.2 9885.1 382515.0 384861.0 408025.0 411199.0 411949.0 75454.0 78898.6 79942.6 80451.6 82426.0 886.0 891.1 917.2 921.1 921.7 15085.8 15259.5 15804.7 15853.5 15958.9 27165.0 27261.0 27612.4 35292.1 36954.0 49494.5 49857.3 50474.2 50651.0 52519.7 7020.5 7069.9 7070.8 7075.9 7240.3 9453.7 11422.7 11426.6 11526.5 11670.9 9980.2 10309.2 10416.9 10759.3 10847.7 9854.6 10298.8 10449.7 10462.9 10535.6 9573.2 10183.4 10422.5 10626.6 10670.2 6756.5 6880.2 6952.8 6998.0 7267.1 8056.4 9463.2 9518.5 9622.8 9757.5 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#3] mootools.html Cycles:180 Average:5175.18 Median:4685.89 stddev:2984.95 (63.7%) stddev-sans-first:2979.64 04:26:22 INFO - PROCESS | 6584 | Values: 1371.6 1422.3 1511.3 1684.7 1723.6 6751.7 7651.7 7666.0 8145.9 8154.8 7750.8 8012.0 8023.2 8026.7 8040.5 2202.9 2230.3 2233.9 2237.6 2237.9 2146.7 2148.8 2203.3 2214.7 2230.6 2153.8 2165.4 2180.7 2182.2 2220.4 2064.3 2071.4 2075.2 2080.9 2089.7 2134.5 2164.0 2170.2 2192.0 2198.5 7868.5 7920.6 7926.4 7928.5 7939.5 4551.0 4697.6 4717.1 4732.9 4734.8 2721.9 2814.1 2818.3 2854.7 2890.6 927.8 955.0 958.8 994.6 995.9 10826.4 10833.1 10849.6 10860.7 10879.7 3927.4 4085.6 4227.1 4243.8 4247.2 9223.5 9285.8 9299.6 9312.6 9326.6 4539.6 4550.9 4670.2 4683.6 4688.1 3702.8 4135.2 4237.8 4246.9 4264.3 3512.8 3590.4 3687.4 3707.1 3799.8 1131.4 1168.8 1186.1 1189.3 1194.6 780.3 793.3 801.3 828.0 838.5 4977.1 5046.8 5129.8 5194.7 5288.5 404.3 418.3 421.6 421.7 429.4 3328.0 3330.5 3356.2 3373.2 3428.0 9630.0 9924.9 10029.5 10033.8 10068.3 10009.2 10021.6 10030.2 10046.9 10073.8 7373.4 7468.9 7528.6 7603.6 7669.0 5060.0 5097.2 5125.3 5149.5 5220.7 8951.1 9097.2 9139.1 9149.9 9245.6 9231.1 9267.6 9357.7 9359.1 9363.1 5967.4 6593.4 6751.0 6898.7 6964.2 7587.9 7634.7 7666.2 7699.6 7703.3 6654.9 6745.2 6809.6 6829.8 6873.7 6663.7 6733.8 6741.5 6883.4 6931.7 6067.5 6266.6 6317.7 6330.6 6334.2 4281.7 4381.3 4484.0 4492.8 4554.6 4534.7 4654.9 4672.6 4692.5 4786.5 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#4] prototype.html Cycles:180 Average:4458.57 Median:5087.89 stddev:1288.34 (25.3%) stddev-sans-first:1253.50 04:26:22 INFO - PROCESS | 6584 | Values: 295.7 298.5 307.9 310.7 314.1 4906.7 4966.9 5132.6 5185.2 5194.8 4971.2 5018.5 5059.7 5064.9 5087.9 3986.6 3995.8 4005.2 4025.1 4033.3 3936.5 3998.2 4010.2 4039.2 4040.2 3941.9 3951.3 3958.5 3960.4 3986.7 3941.8 3961.0 3975.7 3986.6 3994.8 3508.5 3511.2 3518.7 3524.2 3545.1 4936.3 5005.1 5006.2 5027.3 5087.9 4512.9 4513.2 4560.6 4565.5 4565.5 5333.2 5334.9 5368.4 5387.1 5391.0 3714.7 3794.6 3803.8 3813.5 3843.2 5561.5 5594.2 5611.8 5654.1 5664.4 3941.9 3948.4 3957.8 3959.8 3971.3 3880.3 3970.7 4012.9 4015.3 4032.7 4516.2 4535.4 4539.3 4541.7 4542.3 5383.9 5386.7 5387.4 5416.7 5425.6 1315.2 1338.3 1371.5 1388.9 1406.9 942.3 945.9 949.5 969.6 974.3 4662.7 4677.2 4704.3 4708.5 4711.5 5413.2 5417.2 5419.7 5421.9 5453.3 4541.5 4665.3 4678.7 4704.2 4712.9 2913.6 2953.0 2953.8 2959.8 2960.9 5225.8 5244.4 5247.3 5266.8 5273.6 5334.8 5608.9 5664.6 5682.6 5687.4 5172.1 5216.2 5245.7 5249.9 5255.5 5508.7 5575.7 5594.4 5594.6 5598.7 5243.5 5414.8 5418.6 5452.1 5472.3 5191.0 5219.8 5237.3 5241.0 5270.1 3979.4 4007.5 4047.2 4050.9 4053.6 5245.6 5257.4 5520.5 5522.7 5552.3 5219.6 5363.5 5389.9 5396.0 5401.2 5348.9 5357.1 5359.2 5379.4 5405.8 5102.3 5212.8 5261.7 5271.5 5306.5 5359.0 5365.9 5390.7 5408.8 5421.0 5261.6 5285.8 5291.3 5302.9 5331.0 04:26:22 INFO - PROCESS | 6584 | 04:26:22 INFO - PROCESS | 6584 | [#5] yui.html Cycles:180 Average:16984.67 Median:555.26 stddev:24009.07 (4323.9%) stddev-sans-first:24045.06 04:26:22 INFO - PROCESS | 6584 | Values: 641.5 730.4 738.6 743.0 745.8 12779.9 13733.9 13795.4 13803.9 13930.6 12725.9 13131.2 13237.1 13269.7 13355.3 752.0 771.1 776.9 778.7 779.2 622.2 772.2 789.4 793.9 798.6 827.0 830.6 834.6 836.5 840.1 828.4 829.5 829.7 830.9 831.4 605.2 606.3 607.7 608.7 611.5 13399.5 13492.7 13492.9 13514.4 13538.9 13236.5 13287.5 13377.9 13567.4 13691.2 10261.9 10667.6 10695.4 10769.2 10978.6 3259.8 3291.8 3303.8 3350.7 3354.2 61413.0 62855.7 63547.0 63946.4 65135.0 10045.2 10194.4 10225.7 10278.3 10460.9 17001.4 17760.6 19784.6 19993.3 20199.0 6878.6 6909.7 7150.0 7160.8 7187.1 3775.4 3775.4 3865.5 3898.3 3900.0 2808.3 2881.2 2889.9 2907.4 2917.4 510.7 519.1 523.5 527.0 527.2 497.8 544.6 554.4 555.8 558.7 8099.5 8247.4 8430.7 8447.2 8995.3 554.8 576.7 595.4 604.5 606.7 3598.2 3724.8 3833.6 3977.3 3982.0 65246.7 91907.0 93527.0 94017.0 95080.0 49679.5 52539.0 83827.6 83899.6 84954.6 63579.0 75533.2 76123.0 76570.6 77030.2 7178.1 7192.9 7246.9 7341.0 7400.6 44673.1 45478.0 45846.0 47281.8 47520.8 58765.0 60010.7 64874.4 65949.0 66620.3 9097.2 9255.2 9281.4 9314.6 9431.6 10699.7 10888.9 11061.5 11104.4 11109.9 10347.1 10589.9 10687.7 10837.6 10872.2 10327.1 10385.3 10499.8 10625.1 10660.4 10048.5 10159.4 10209.2 10613.9 10645.0 8285.3 8595.7 8681.3 8780.1 8856.2 8772.6 9329.0 9345.7 9345.9 9379.9 04:26:22 INFO - PROCESS | 6584 | -------- Summary: end -------- 04:26:22 INFO - PROCESS | 6584 | 04:26:23 INFO - TEST-INFO | 6584: exit 0 04:26:23 INFO - TEST-OK | dromaeo_css | took 1116902ms 04:26:23 INFO - TEST-START | kraken 04:26:23 INFO - operating with platform_type : linux_ 04:26:23 INFO - Initialising browser for kraken test... 04:26:23 INFO - TEST-INFO | started process 6833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ng1s3/profile http://localhost:59533/getInfo.html) 04:26:28 INFO - PROCESS | 6833 | __metrics Screen width/height:1600/1200 04:26:28 INFO - PROCESS | 6833 | colorDepth:24 04:26:28 INFO - PROCESS | 6833 | Browser inner width/height: 1024/697 04:26:28 INFO - PROCESS | 6833 | __metrics 04:26:28 ERROR - PROCESS | 6833 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:26:29 INFO - TEST-INFO | 6833: exit 0 04:26:29 INFO - Browser initialized. 04:26:29 INFO - Running cycle 1/1 for kraken test... 04:26:29 INFO - TEST-INFO | started process 6954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ng1s3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:41 INFO - PROCESS | 6954 | RSS: Main: 168452096 04:26:41 INFO - PROCESS | 6954 | 04:26:44 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:45 INFO - PROCESS | 6954 | RSS: Main: 173973504 04:26:45 INFO - PROCESS | 6954 | 04:26:47 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-dft) 04:26:48 INFO - PROCESS | 6954 | RSS: Main: 173047808 04:26:48 INFO - PROCESS | 6954 | 04:26:51 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-fft) 04:26:52 INFO - PROCESS | 6954 | RSS: Main: 169078784 04:26:52 INFO - PROCESS | 6954 | 04:26:54 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-oscillator) 04:26:54 INFO - PROCESS | 6954 | RSS: Main: 169787392 04:26:54 INFO - PROCESS | 6954 | 04:26:57 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:57 INFO - PROCESS | 6954 | RSS: Main: 169971712 04:26:57 INFO - PROCESS | 6954 | 04:27:00 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:01 INFO - PROCESS | 6954 | RSS: Main: 170524672 04:27:01 INFO - PROCESS | 6954 | 04:27:05 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:05 INFO - PROCESS | 6954 | RSS: Main: 167419904 04:27:05 INFO - PROCESS | 6954 | 04:27:08 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59533/tests/kraken/driver.html?testName=json-parse-financial) 04:27:09 INFO - PROCESS | 6954 | RSS: Main: 169316352 04:27:09 INFO - PROCESS | 6954 | 04:27:11 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:11 INFO - PROCESS | 6954 | RSS: Main: 169459712 04:27:11 INFO - PROCESS | 6954 | 04:27:13 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:14 INFO - PROCESS | 6954 | RSS: Main: 169803776 04:27:14 INFO - PROCESS | 6954 | 04:27:16 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:17 INFO - PROCESS | 6954 | RSS: Main: 170037248 04:27:17 INFO - PROCESS | 6954 | 04:27:19 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:20 INFO - PROCESS | 6954 | RSS: Main: 170438656 04:27:20 INFO - PROCESS | 6954 | 04:27:23 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:24 INFO - PROCESS | 6954 | RSS: Main: 170106880 04:27:24 INFO - PROCESS | 6954 | 04:27:25 INFO - PROCESS | 6954 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59533/tests/kraken/driver.html?testName=ai-astar) 04:27:26 INFO - PROCESS | 6954 | RSS: Main: 171212800 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | __start_tp_report 04:27:26 INFO - PROCESS | 6954 | _x_x_mozilla_page_load 04:27:26 INFO - PROCESS | 6954 | _x_x_mozilla_page_load_details 04:27:26 INFO - PROCESS | 6954 | |i|pagename|runs| 04:27:26 INFO - PROCESS | 6954 | |0;ai-astar;106;114;109;114;114;115;115;114;116;116 04:27:26 INFO - PROCESS | 6954 | |1;audio-beat-detection;161;121;155;185;123;154;150;125;192;126 04:27:26 INFO - PROCESS | 6954 | |2;audio-dft;165;164;164;166;174;164;165;164;166;164 04:27:26 INFO - PROCESS | 6954 | |3;audio-fft;76;76;77;158;77;76;77;76;170;76 04:27:26 INFO - PROCESS | 6954 | |4;audio-oscillator;86;87;151;86;86;86;140;85;86;149 04:27:26 INFO - PROCESS | 6954 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;117;119;117 04:27:26 INFO - PROCESS | 6954 | |6;imaging-darkroom;149;150;147;147;147;148;148;149;147;148 04:27:26 INFO - PROCESS | 6954 | |7;imaging-desaturate;96;96;95;96;97;95;96;95;96;96 04:27:26 INFO - PROCESS | 6954 | |8;json-parse-financial;67;66;65;65;65;64;66;67;64;68 04:27:26 INFO - PROCESS | 6954 | |9;json-stringify-tinderbox;66;66;65;65;66;66;66;65;66;67 04:27:26 INFO - PROCESS | 6954 | |10;stanford-crypto-aes;82;82;82;81;82;81;82;80;84;80 04:27:26 INFO - PROCESS | 6954 | |11;stanford-crypto-ccm;129;132;139;130;145;140;141;131;164;130 04:27:26 INFO - PROCESS | 6954 | |12;stanford-crypto-pbkdf2;165;169;173;165;169;174;171;166;169;165 04:27:26 INFO - PROCESS | 6954 | |13;stanford-crypto-sha256-iterative;69;70;68;66;69;67;68;71;68;66 04:27:26 INFO - PROCESS | 6954 | __end_tp_report 04:27:26 INFO - PROCESS | 6954 | __start_cc_report 04:27:26 INFO - PROCESS | 6954 | _x_x_mozilla_cycle_collect,1034 04:27:26 INFO - PROCESS | 6954 | __end_cc_report 04:27:26 INFO - PROCESS | 6954 | __startTimestamp1469100446192__endTimestamp 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | ------- Summary: start ------- 04:27:26 INFO - PROCESS | 6954 | Number of tests: 14 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:3.23 (2.8%) stddev-sans-first:2.09 04:27:26 INFO - PROCESS | 6954 | Values: 106.0 114.0 109.0 114.0 114.0 115.0 115.0 114.0 116.0 116.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:25.64 (16.6%) stddev-sans-first:26.83 04:27:26 INFO - PROCESS | 6954 | Values: 161.0 121.0 155.0 185.0 123.0 154.0 150.0 125.0 192.0 126.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 04:27:26 INFO - PROCESS | 6954 | Values: 165.0 164.0 164.0 166.0 174.0 164.0 165.0 164.0 166.0 164.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.06 (48.8%) stddev-sans-first:38.73 04:27:26 INFO - PROCESS | 6954 | Values: 76.0 76.0 77.0 158.0 77.0 76.0 77.0 76.0 170.0 76.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:86.00 stddev:29.44 (34.2%) stddev-sans-first:30.48 04:27:26 INFO - PROCESS | 6954 | Values: 86.0 87.0 151.0 86.0 86.0 86.0 140.0 85.0 86.0 149.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:27:26 INFO - PROCESS | 6954 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 119.0 117.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:27:26 INFO - PROCESS | 6954 | Values: 149.0 150.0 147.0 147.0 147.0 148.0 148.0 149.0 147.0 148.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:27:26 INFO - PROCESS | 6954 | Values: 96.0 96.0 95.0 96.0 97.0 95.0 96.0 95.0 96.0 96.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.34 (2.0%) stddev-sans-first:1.33 04:27:26 INFO - PROCESS | 6954 | Values: 67.0 66.0 65.0 65.0 65.0 64.0 66.0 67.0 64.0 68.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:27:26 INFO - PROCESS | 6954 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 67.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 04:27:26 INFO - PROCESS | 6954 | Values: 82.0 82.0 82.0 81.0 82.0 81.0 82.0 80.0 84.0 80.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:139.50 stddev:10.71 (7.7%) stddev-sans-first:10.84 04:27:26 INFO - PROCESS | 6954 | Values: 129.0 132.0 139.0 130.0 145.0 140.0 141.0 131.0 164.0 130.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:3.34 (2.0%) stddev-sans-first:3.28 04:27:26 INFO - PROCESS | 6954 | Values: 165.0 169.0 173.0 165.0 169.0 174.0 171.0 166.0 169.0 165.0 04:27:26 INFO - PROCESS | 6954 | 04:27:26 INFO - PROCESS | 6954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.62 (2.4%) stddev-sans-first:1.69 04:27:26 INFO - PROCESS | 6954 | Values: 69.0 70.0 68.0 66.0 69.0 67.0 68.0 71.0 68.0 66.0 04:27:26 INFO - PROCESS | 6954 | -------- Summary: end -------- 04:27:26 INFO - PROCESS | 6954 | 04:27:27 INFO - TEST-INFO | 6954: exit 0 04:27:27 INFO - TEST-OK | kraken | took 63733ms 04:27:27 INFO - SUITE-END | took 1180s 04:27:27 INFO - Completed test suite (00:19:40) 04:27:27 INFO - javascript benchmark 04:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6419.123693854183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.030958545338, 2622.5017246723123, 2642.907498237562, 2648.655674762281, 2668.332916770806, 4721.10299043182, 4787.042591481701, 4824.276358546211, 4838.129136755382, 4875.293082503039, 4633.073385322932, 4762.380890484233, 4767.6185905127595, 4777.713337199771, 4854.951450485494, 4391.429114215155, 4414.183376075421, 4460.174867649495, 4486.439195100613, 4518.412606361185, 4382.649388048964, 4472.08322293929, 4515.61617262533, 4546.204414227514, 4571.839985600504, 4289.549597292271, 4336.609705126522, 4361.738295702268, 4376.5623437656295, 4422.579854913778, 4419.0, 4436.600705936449, 4439.178751930903, 4461.486929003141, 4471.262241730111, 4384.4081049058605, 4404.779761011969, 4426.22541055314, 4429.800658970354, 4462.419885414908, 4649.744264065475, 4690.812367505296, 4714.599259062984, 4761.976190119062, 4821.083994041121, 5019.322391477141, 5053.620978426633, 5055.469175736532, 5087.542121209072, 5097.694138351673, 5077.365329333833, 5101.821436249714, 5106.591472682177, 5108.2848401223855, 5154.020736060136, 4640.767961601974, 4679.298105284234, 4697.4832768395445, 4733.029728905635, 4735.147673418817, 5161.4322424533275, 5164.715940623227, 5165.845024649267, 5182.119039763249, 5203.583713303003, 4944.332515110486, 4966.180580204298, 4977.90044199114, 5002.299678045004, 5018.447970723218, 4975.0796102721115, 5055.9241611375855, 5062.341895553554, 5073.086844368049, 5095.0828850806465, 5033.446320904697, 5042.773075211624, 5048.848534543969, 5069.670471419346, 5075.8984820303385, 5030.220315851049, 5056.165732654144, 5071.4928507149725, 5075.974620126875, 5092.541671249605, 4208.642265407413, 4238.597333253336, 4291.463567054118, 4301.268784306675, 4328.740275583412, 3783.0, 3786.053486628343, 3786.413105968579, 3792.1467669774634, 3822.7515211511163, 4450.443694538183, 4511.233090374644, 4523.954760452353, 4579.290210017452, 4594.379758732528, 5022.472640372781, 5023.79904803811, 5073.949260507421, 5078.111330517218, 5175.585953123741, 4414.668899832525, 4466.173757854807, 4472.485664148665, 4480.932786008212, 4485.394471746273, 4297.957020429756, 4307.655387568987, 4324.8486302979245, 4351.042770590465, 4351.8476853309985, 4725.669203155746, 4816.735079570727, 4882.658213924991, 4925.729084900365, 4930.704157750403, 5200.089984252816, 5208.9739551302, 5213.035588416155, 5231.29377534028, 5245.475452454724, 4883.291922671122, 4901.460839307744, 4903.362562866804, 4904.558589726942, 4908.435529914105, 4928.334674818853, 4940.975295123501, 4946.653734238569, 4968.577670897869, 5120.846374608767, 5025.623078269071, 5025.974870125626, 5028.974855125847, 5045.672031317952, 5056.393232811939, 4904.288878112725, 4909.950900491092, 4910.337104490991, 4914.533119353656, 4951.034548263054, 4860.198067318853, 4941.50584941503, 4951.183054795918, 4973.35346404965, 5011.924821127759, 4841.685290456109, 4852.1508735971765, 4948.15881300187, 4952.059108769322, 4969.130402179532, 5055.747212639427, 5063.0380227756605, 5069.214271787879, 5069.7465126744255, 5102.6938383695615, 4745.952540474551, 4831.0, 4877.561019508261, 4942.357493525818, 5002.199648056294], "value": 4680.709234115005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.5985290590774, 560.2548610348236, 568.7525926222094, 579.9391063938286, 603.2188316130611, 36487.81756091219, 40355.798221008925, 40358.59641403585, 40413.19173616526, 40421.393679094836, 40284.0, 40738.0, 40817.0, 40891.59108408915, 40891.79554102226, 7796.766097017098, 7867.095284042322, 7886.408519361043, 7936.0, 7945.0, 7782.299593036626, 7788.026496687914, 7790.493617914845, 7843.058832940055, 7871.763847084568, 7853.489523181003, 7878.1334053254095, 7880.5271683698875, 7885.053793544783, 7894.60526973649, 7843.450958432912, 7860.882086768703, 7880.408969327266, 7888.684452621888, 7906.090799558038, 7695.807604809868, 7808.063032436087, 7830.138684744674, 7833.529988200727, 7848.843023139505, 37509.81245093785, 38029.80985095084, 38128.618713812786, 38161.0, 38261.61738382608, 2542.6186072089336, 2818.3799564095866, 2858.771298296131, 3045.9847700761575, 3136.498160294342, 27770.444591108266, 27811.86094069537, 28319.29201769972, 28448.28879278014, 28919.26484410921, 3337.7830441021497, 3374.578177727784, 3384.086296699902, 3481.251530920839, 3519.718422526217, 261579.0, 261713.0, 266213.0, 266607.0, 267992.0, 54322.0, 54501.1824822628, 54971.175432368545, 54996.725016374665, 55143.72428137914, 32969.17577060593, 34039.489407658904, 34443.4833477498, 36006.63993360033, 57555.424445755845, 14855.48005819791, 15043.097414155185, 15056.247187640793, 15059.774103388458, 15061.472848450252, 11277.661670149908, 11381.658550243506, 11393.430328483542, 11406.714832129097, 11429.942850285695, 18564.0, 18595.721064184047, 18632.347867824563, 18632.44102676922, 18770.81229187718, 6873.759418420432, 6911.827204319932, 7166.713331466683, 7214.531055481377, 7249.275072492814, 778.6029125146104, 797.9760607181794, 883.902770695223, 899.1907283444951, 976.4531862157214, 25825.0, 29067.41865162685, 29325.85337073301, 29440.852795735886, 29670.55494167589, 920.0540856089457, 937.2080591899834, 986.1666891476691, 1012.0126700798829, 1017.2878984710732, 13993.930030349784, 14023.368948397347, 14277.857221427652, 14630.195339256443, 14769.113853168845, 400273.0, 402365.0, 403134.0, 404403.0, 406398.0, 48356.27465588019, 48606.51393486091, 48608.78478038007, 48703.0, 48762.75618621955, 1197.4072833947253, 1218.1838168427175, 1251.7997120460682, 1252.555342853274, 1260.9117361784588, 25571.48857022812, 26713.599296010965, 26908.501894753557, 27518.312042199104, 27762.44475110446, 42043.57956420519, 42301.153976920905, 42502.149957001304, 42606.786966064974, 42612.36081458843, 372032.0, 375516.0, 375679.0, 375729.0, 376909.0, 38295.42556861705, 38890.6110938887, 38929.41605875971, 38996.805015974736, 39103.608963909996, 42025.0, 42302.153956920076, 42654.78672606617, 43250.567494324656, 43762.0, 35915.820420897726, 36258.0, 36380.454293185096, 36574.0, 36598.451023235204, 36200.45699314565, 36360.27279454449, 36685.26629467449, 36727.0, 37324.0, 32106.19734506656, 36232.27535449224, 36410.0, 36923.0, 37471.43792843164, 28134.577981329887, 30598.694013059583, 30709.69290307068, 31170.844145780033, 31208.53187202239, 25066.122685705912, 25083.749162508142, 25375.492490150464, 25652.35869103213, 25705.485890282464], "value": 17688.59626656295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.90489020409586, 359.55774397491103, 366.2418793098287, 370.9814509274536, 383.1799948111043, 16028.919855400736, 16788.664226715457, 17087.48737537873, 17215.655686886254, 17267.654646907053, 16415.753763693556, 16784.412545560906, 17183.140842957833, 17342.739858902096, 17392.739108913345, 4999.050180465709, 5238.790448382079, 5243.764030618631, 5244.0, 5246.029484545371, 3807.143392736626, 5186.196139598368, 5737.856553586173, 5991.221141251631, 6013.917494850925, 6065.757369705207, 6077.209962704865, 6085.604435711687, 6091.390860913917, 6095.512359011268, 5111.744412779365, 5327.094393953037, 5366.06093933562, 5461.317335333083, 5462.371827239878, 5150.253213284052, 5284.656497327662, 5316.627836051478, 5320.787168513255, 5341.092014357569, 12275.631731048083, 12500.0, 12516.311602861839, 12675.239485630891, 12676.23942563449, 1717.2959086774488, 1891.4514790710678, 1937.6705959986837, 2008.5079155606825, 2387.806096951524, 9254.148454243905, 9408.576614052316, 9439.622415103388, 9483.857742133874, 9620.278479114024, 1607.23656263274, 1664.7752553405257, 1726.3526177683368, 1731.7662115614482, 1778.9911050444664, 67352.32647673509, 72103.63948180278, 72427.0, 72477.63761181213, 73396.89904651488, 9995.200383969264, 10127.64553240633, 10154.593816247267, 10160.33957792741, 10309.278350515391, 13551.0, 13595.116317439533, 13609.387577559033, 13715.725685486434, 13721.931390343185, 6990.26602206761, 7157.2127066022695, 7196.568205907663, 7282.162551306562, 7394.149672787698, 6917.757878474229, 6922.238553759083, 7043.7534686285735, 7112.288771122846, 7174.31843974832, 4174.102567947906, 4186.853460128881, 4249.917540405179, 4305.612494875413, 4396.758178300161, 1515.454436402894, 1550.317860141534, 1580.8023997000375, 1796.1468302556182, 1888.1975160556983, 839.0686338164633, 851.7657644147909, 901.0403919825364, 913.456493386434, 963.2919803944095, 16314.428994985119, 16876.746848797276, 17122.40071597488, 17349.826501735075, 17649.294028238983, 816.7223144130905, 818.9549574773325, 864.6887120636566, 867.7266661001764, 907.5144797533288, 9133.415223679554, 9722.416655000723, 9727.270454715925, 9804.166645835041, 9885.110340069428, 382515.0, 384861.0, 408025.0, 411199.0, 411949.0, 75454.0, 78898.60550697324, 79942.60028699819, 80451.59774201091, 82426.0, 885.964561417549, 891.0955380288882, 917.1516347378648, 921.1341339141186, 921.6912334367928, 15085.849141508445, 15259.465918692793, 15804.68390632204, 15853.52439426819, 15958.920205399363, 27165.0, 27261.045863394687, 27612.447751045267, 35292.11786703512, 36954.0, 49494.50505494899, 49857.252141217185, 50474.242886356, 50651.0, 52519.73740131275, 7020.543664661985, 7069.858602828018, 7070.7525236616475, 7075.893861592183, 7240.312170343809, 9453.669121580986, 11422.714432139262, 11426.600068997877, 11526.481308340977, 11670.94164529172, 9980.201583873128, 10309.22680798958, 10416.947915260678, 10759.30064545802, 10847.674569762605, 9854.605815767576, 10298.794024119625, 10449.738756531147, 10462.895371046496, 10535.57857685684, 9573.18627916635, 10183.388996660224, 10422.478876056319, 10626.574937002433, 10670.19973502006, 6756.493263005196, 6880.208775990825, 6952.791416257521, 6997.965010174917, 7267.127944646676, 8056.355491560544, 9463.195628371666, 9518.476483793458, 9622.807543849223, 9757.51212439361], "value": 8024.473092576852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.5542448704168, 1422.2959634980684, 1511.3047997920962, 1684.7388654758502, 1723.5518765121064, 6751.662416879149, 7651.732189373359, 7665.961670191648, 8145.91854081459, 8154.8369032619385, 7750.806229844243, 8012.0, 8023.197680231974, 8026.678932842679, 8040.517568945853, 2202.8568143070647, 2230.308604332654, 2233.8771367574777, 2237.552489502098, 2237.85453945493, 2146.6887301341294, 2148.79586439288, 2203.2839327218717, 2214.6677998300224, 2230.643097104464, 2153.7630860605323, 2165.372042107787, 2180.7274090738656, 2182.225310014938, 2220.367195349326, 2064.267185149273, 2071.420002399323, 2075.190675636503, 2080.9479763005893, 2089.696993935871, 2134.455713792973, 2163.9783602163934, 2170.218721260345, 2191.9697742061207, 2198.5492973940304, 7868.527888326662, 7920.64357103926, 7926.445148839583, 7928.524288542706, 7939.523628582304, 4550.954490455086, 4697.553732395417, 4717.103750287434, 4732.881677958044, 4734.810607575693, 2721.9047333343437, 2814.0994881637885, 2818.3236023354452, 2854.728800763924, 2890.609767681357, 927.8097989912052, 954.9809003819885, 958.7603099225194, 994.602159136344, 995.8605795188679, 10826.404547749871, 10833.133349332113, 10849.566017359297, 10860.67417977462, 10879.673609791718, 3927.4108883667677, 4085.611866872642, 4227.070044590185, 4243.830246790156, 4247.17180149874, 9223.49270790113, 9285.767855803659, 9299.581518831668, 9312.580933857993, 9326.580303886341, 4539.6368290536675, 4550.863474095716, 4670.182718024332, 4683.648726345537, 4688.132695451352, 3702.777833330009, 4135.17296540693, 4237.8304867805555, 4246.893827654333, 4264.275073237557, 3512.8067956262653, 3590.4202151053455, 3687.4284485904727, 3707.0547010512146, 3799.848006079726, 1131.3833960491552, 1168.8129899216085, 1186.1163433242118, 1189.3339729751367, 1194.635636130971, 780.282140430805, 793.262266092528, 801.3308887079238, 828.0, 838.4927119092982, 4977.104121258209, 5046.823361182341, 5129.769160387791, 5194.662346947436, 5288.524032836986, 404.3429427180831, 418.30561268294485, 421.58473903205316, 421.711127877405, 429.37311525173595, 3327.9500807487907, 3330.4837750148768, 3356.2112903467664, 3373.1904342958005, 3427.9828600857336, 9629.951850240845, 9924.900750992398, 10029.498525073717, 10033.849492257623, 10068.295219334575, 10009.24930630191, 10021.599136034623, 10030.247731420173, 10046.899531004596, 10073.848892266622, 7373.410127189812, 7468.925310746823, 7528.623568821647, 7603.581803000888, 7668.961655191688, 5060.0, 5097.209932460474, 5125.308083408841, 5149.459306772735, 5220.686758794484, 8951.149640784115, 9097.1812536872, 9139.086091391073, 9149.862752058858, 9245.61315802635, 9231.123043310874, 9267.6292948284, 9357.672481463116, 9359.110884465965, 9363.110504502061, 5967.37342579023, 6593.406593406617, 6750.966245168743, 6898.724051037902, 6964.164300283998, 7587.924120758722, 7634.732784352521, 7666.233376662289, 7699.576523291273, 7703.268189521987, 6654.866902662016, 6745.156855393076, 6809.625470599165, 6829.795106146824, 6873.725050998104, 6663.7001334941015, 6733.764318248838, 6741.460683145238, 6883.380495755406, 6931.653417329013, 6067.514598832171, 6266.561340706289, 6317.715702793477, 6330.620162790247, 6334.239891213084, 4281.700280980302, 4381.342798580238, 4484.0, 4492.775361231991, 4554.635629149726, 4534.7052441591195, 4654.93017604743, 4672.556107169813, 4692.50728673498, 4786.473487916396], "value": 4073.839280267846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.74565873348917, 298.46872566831036, 307.86300096457086, 310.72500836759474, 314.1157641239911, 4906.705597664142, 4966.925496117561, 5132.563732082773, 5185.170372740362, 5194.844154675366, 4971.154903666376, 5018.473060328659, 5059.747012649362, 5064.873378165547, 5087.872803179922, 3986.6013398660193, 3995.8002099895034, 4005.2390045891334, 4025.134596061846, 4033.2740106780766, 3936.5079365079364, 3998.2003599280115, 4010.1979604079156, 4039.2123535910364, 4040.1919616076757, 3941.901452463697, 3951.308521008826, 3958.5447673517483, 3960.4059391091423, 3986.70099742519, 3941.8226179821977, 3961.0, 3975.721699481023, 3986.64787775214, 3994.7802870842092, 3508.5088087667746, 3511.227529943408, 3518.6833185013215, 3524.2246705724956, 3545.0782796472845, 4936.259561065869, 5005.072032860744, 5006.199008158677, 5027.296178535008, 5087.9061001884775, 4512.909741805179, 4513.210188217049, 4560.612347950429, 4565.488981060436, 4565.5206203348835, 5333.173358129496, 5334.946650533522, 5368.4363141869935, 5387.0841956867425, 5390.97304513475, 3714.665680088778, 3794.6015668354976, 3803.7717736935874, 3813.466114743938, 3843.1552854629654, 5561.499465048165, 5594.216809646653, 5611.775528978836, 5654.123610840285, 5664.40523745005, 3941.921161576752, 3948.4137889682306, 3957.7730903420033, 3959.8020098994934, 3971.3050216212046, 3880.262750077476, 3970.7021973352116, 4012.8996775080273, 4015.2772500949527, 4032.689375952827, 4516.16450956574, 4535.433070866142, 4539.341795439643, 4541.6593755468475, 4542.250528662734, 5383.946160538423, 5386.703731294738, 5387.3804512481565, 5416.729163541807, 5425.565954723613, 1315.2043013976597, 1338.2773302416585, 1371.4719832864419, 1388.9166650001032, 1406.8944829137856, 942.260737989615, 945.8533927241289, 949.4920217683506, 969.5879251318162, 974.2741657465234, 4662.650301227422, 4677.18149323867, 4704.29435584665, 4708.4820669726305, 4711.528847115261, 5413.2150838128255, 5417.241586177859, 5419.729013549386, 5421.945780542223, 5453.291072160594, 4541.5231400703115, 4665.250531050856, 4678.672492925531, 4704.223803072455, 4712.88217794551, 2913.592097106407, 2952.9664617384174, 2953.7636989040825, 2959.77801664876, 2960.851957402121, 5225.843224703265, 5244.423113457593, 5247.317848679647, 5266.78863861314, 5273.630845840754, 5334.839954801362, 5608.887822243532, 5664.5751568631695, 5682.602217844711, 5687.402822703557, 5172.120739474299, 5216.191490318931, 5245.6852588844795, 5249.895002099936, 5255.527002569787, 5508.724563771875, 5575.717584955401, 5594.4125866785025, 5594.608377413542, 5598.720063996702, 5243.475652434726, 5414.756335964812, 5418.593605479526, 5452.073147565003, 5472.261244731911, 5190.97404512975, 5219.8434046978655, 5237.250443517184, 5241.0, 5270.077736396192, 3979.42298366741, 4007.5391329997424, 4047.2310261050307, 4050.8784736457956, 4053.5946405359227, 5245.554127899019, 5257.447967963309, 5520.475554822286, 5522.668639881459, 5552.250446189712, 5219.634625576326, 5363.5440987516495, 5389.946100538945, 5396.0, 5401.2168235606405, 5348.946510535001, 5357.142857142839, 5359.169328754049, 5379.408265090915, 5405.8107966221, 5102.311187989574, 5212.8010557571215, 5261.710605916558, 5271.499207575274, 5306.495882891119, 5358.981793459387, 5365.865853353697, 5390.730463476732, 5408.810691625774, 5421.0, 5261.605379596469, 5285.762140703754, 5291.259223708761, 5302.867428314169, 5331.0], "value": 4047.7941684012135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.5220660607848, 730.4266151071413, 738.6048464071723, 742.9702811887523, 745.7911784700283, 12779.936100319497, 13733.93133034336, 13795.379207935643, 13803.930980345109, 13930.582082537527, 12725.936370318159, 13131.21212727237, 13237.073404861663, 13269.734605307887, 13355.265460399698, 751.9774406767806, 771.0824119298045, 776.9028871391076, 778.7313376884965, 779.1935346915943, 622.1600838867538, 772.2277722277722, 789.3685051958439, 793.892824468698, 798.5887268056955, 827.0323721246157, 830.5888585150359, 834.6202477872554, 836.4646626159263, 840.0801122770556, 828.3745771942175, 829.4857188543111, 829.6515463505312, 830.9169083091703, 831.4470876866876, 605.1799811255729, 606.2906399512536, 607.7083000159904, 608.6986941464004, 611.5046812082228, 13399.464021439131, 13492.662683432894, 13492.932535337359, 13514.391852366569, 13538.864611353858, 13236.536721214807, 13287.534936277281, 13377.933110334387, 13567.389467473988, 13691.178529288274, 10261.948690256575, 10667.626633067805, 10695.411752353617, 10769.207747444903, 10978.560857565768, 3259.837008149583, 3291.769576129672, 3303.801771893694, 3350.731941444703, 3354.1782263345635, 61413.0, 62855.68572157156, 63547.04679429812, 63946.3605363945, 65135.0, 10045.19638428924, 10194.388336699822, 10225.744356391, 10278.280520363653, 10460.895391045991, 17001.40495082691, 17760.555986100193, 19784.604307914047, 19993.300234491722, 20199.0, 6878.55289406187, 6909.654517274116, 7150.0, 7160.820979475555, 7187.1375434947095, 3775.433684947225, 3775.4336849472797, 3865.4588357629955, 3898.2788184186015, 3899.951287888565, 2808.3119635689386, 2881.207667891347, 2889.8555072246304, 2907.3749143934156, 2917.3581812001325, 510.6680657572533, 519.1019536202391, 523.5445162708468, 527.0302643136647, 527.211818331589, 497.7710253283458, 544.5616278895448, 554.3790954131399, 555.7693557173727, 558.6899270904687, 8099.514029158269, 8247.381446391424, 8430.704925327584, 8447.197516235949, 8995.28037756978, 554.7559074007423, 576.6741790888135, 595.3629616310593, 604.4710877981765, 606.7057477123592, 3598.172420343283, 3724.776513409204, 3833.597472265372, 3977.3437382831507, 3982.0, 65246.673766631815, 91907.0, 93527.0, 94017.0, 95080.0, 49679.50320496821, 52539.0, 83827.58086209653, 83899.5805020971, 84954.5752271247, 63579.0, 75533.24466755372, 76123.0, 76570.61714691503, 77030.2296977023, 7178.0808257087, 7192.892106618509, 7246.927530724625, 7341.0, 7400.629968501661, 44673.10653786841, 45478.0, 45846.0, 47281.76359118182, 47520.7623961878, 58765.0, 60010.69994649999, 64874.35125648872, 65949.0, 66620.33379666142, 9097.1812536872, 9255.167034966886, 9281.39670921388, 9314.580843861906, 9431.62273509052, 10699.732331908534, 10888.94555527249, 11061.5022323994, 11104.389258590854, 11109.888901110886, 10347.068763811292, 10589.947050265007, 10687.679369618923, 10837.620683276047, 10872.238943273895, 10327.070563649308, 10385.273030888067, 10499.842502362624, 10625.149988000787, 10660.413677247825, 10048.547815348473, 10159.390436573829, 10209.234307426825, 10613.893861061599, 10645.041946224877, 8285.295749861329, 8595.742127736177, 8681.262092722189, 8780.121987801169, 8856.202941735275, 8772.649094036422, 9329.0, 9345.672901448417, 9345.906540934775, 9379.859302110337], "value": 6385.033446115756, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 109.0, 114.0, 114.0, 115.0, 115.0, 114.0, 116.0, 116.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 121.0, 155.0, 185.0, 123.0, 154.0, 150.0, 125.0, 192.0, 126.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 166.0, 174.0, 164.0, 165.0, 164.0, 166.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 158.0, 77.0, 76.0, 77.0, 76.0, 170.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 151.0, 86.0, 86.0, 86.0, 140.0, 85.0, 86.0, 149.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 65.0, 64.0, 66.0, 67.0, 64.0, 68.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 82.0, 81.0, 82.0, 80.0, 84.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 139.0, 130.0, 145.0, 140.0, 141.0, 131.0, 164.0, 130.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 173.0, 165.0, 169.0, 174.0, 171.0, 166.0, 169.0, 165.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 66.0, 69.0, 67.0, 68.0, 71.0, 68.0, 66.0], "value": 68.2, "unit": "score"}]}]} 04:27:27 INFO - Return code: 0 04:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:27:27 ERROR - # TBPL SUCCESS # 04:27:27 INFO - Running post-action listener: _resource_record_post_action 04:27:27 INFO - [mozharness: 2016-07-21 11:27:27.469460Z] Finished run-tests step (success) 04:27:27 INFO - Running post-run listener: _resource_record_post_run 04:27:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540106752; Read time: 12; Write time: 397444 04:27:27 INFO - TinderboxPrint: CPU usage
13.3% 04:27:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:27:27 INFO - TinderboxPrint: I/O write bytes / time
540,106,752 / 397,444 04:27:27 INFO - TinderboxPrint: CPU idle
8,279.7 (86.7%) 04:27:27 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 04:27:27 INFO - TinderboxPrint: Swap in / out
0 / 0 04:27:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250716160; Read time: 0; Write time: 226904 04:27:27 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289390592; Read time: 0; Write time: 170540 04:27:28 INFO - Running post-run listener: _upload_blobber_files 04:27:28 INFO - Blob upload gear active. 04:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:28 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 04:27:28 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:28 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:29 INFO - (blobuploader) - INFO - Done attempting. 04:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:30 INFO - (blobuploader) - INFO - Done attempting. 04:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:54 INFO - (blobuploader) - INFO - Done attempting. 04:27:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:54 INFO - Return code: 0 04:27:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/60004979cea5490978ceea03b1c543594b8d669d3fd3e0d95e2e9bc5572925655299be69f19d920013c5e4f03922ec50a4be68b020b410b79dd7a4733a251cfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7324dcfa156df5958c7adfebe354b9c967365594ef0bb89195870a4969bb734b63f334a6441cb07e9b4f1ff309055f9348cee0e13f31196012912ca69bd20edc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/24d1d4b5b80c7652bd8b74f3f1bd8259814edcb9e956aa903b0a0ce6cef6295f6a4dadb15059ac843345a5139b6fca1d4a2cb66ad16923da1b28349b4858add5"} 04:27:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:54 INFO - Contents: 04:27:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/60004979cea5490978ceea03b1c543594b8d669d3fd3e0d95e2e9bc5572925655299be69f19d920013c5e4f03922ec50a4be68b020b410b79dd7a4733a251cfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7324dcfa156df5958c7adfebe354b9c967365594ef0bb89195870a4969bb734b63f334a6441cb07e9b4f1ff309055f9348cee0e13f31196012912ca69bd20edc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/24d1d4b5b80c7652bd8b74f3f1bd8259814edcb9e956aa903b0a0ce6cef6295f6a4dadb15059ac843345a5139b6fca1d4a2cb66ad16923da1b28349b4858add5"} 04:27:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:54 INFO - Copying logs to upload dir... 04:27:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.750219 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-21 04:27:53.863104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:27:53.866371) ========= 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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/60004979cea5490978ceea03b1c543594b8d669d3fd3e0d95e2e9bc5572925655299be69f19d920013c5e4f03922ec50a4be68b020b410b79dd7a4733a251cfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7324dcfa156df5958c7adfebe354b9c967365594ef0bb89195870a4969bb734b63f334a6441cb07e9b4f1ff309055f9348cee0e13f31196012912ca69bd20edc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/24d1d4b5b80c7652bd8b74f3f1bd8259814edcb9e956aa903b0a0ce6cef6295f6a4dadb15059ac843345a5139b6fca1d4a2cb66ad16923da1b28349b4858add5"} build_url:https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/CsEth1LVQlStwOemJ2oQww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/60004979cea5490978ceea03b1c543594b8d669d3fd3e0d95e2e9bc5572925655299be69f19d920013c5e4f03922ec50a4be68b020b410b79dd7a4733a251cfe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7324dcfa156df5958c7adfebe354b9c967365594ef0bb89195870a4969bb734b63f334a6441cb07e9b4f1ff309055f9348cee0e13f31196012912ca69bd20edc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/24d1d4b5b80c7652bd8b74f3f1bd8259814edcb9e956aa903b0a0ce6cef6295f6a4dadb15059ac843345a5139b6fca1d4a2cb66ad16923da1b28349b4858add5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:27:53.893640) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:27:53.894262) ========= 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=41bf3e9aed84707956354da8000001c5-1469099217.934270-201884418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:27:53.977859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:27:53.978634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:27:53.979277) ========= ========= Total master_lag: 0.19 =========