builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1468030882.66 results: success (0) buildid: 20160708163028 builduid: 7e684ce57b004e89b0920fe47e16f9b3 revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.658266) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.659020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.659599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.680189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.680620) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 19:21:23-- 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% 89.7M=0s 2016-07-08 19:21:23 (89.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092943 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.807163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.807692) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.861664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 19:21:22.862073) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --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=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 19:21:23,299 truncating revision to first 12 chars 2016-07-08 19:21:23,300 Setting DEBUG logging. 2016-07-08 19:21:23,300 attempt 1/10 2016-07-08 19:21:23,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9ec9a9682d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 19:21:24,682 unpacking tar archive at: mozilla-inbound-9ec9a9682d46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.807521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 19:21:24.684757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.685166) ========= script_repo_revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.685685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.685995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.695272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-08 19:21:24.695681) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:25 INFO - MultiFileLogger online at 20160708 19:21:25 in /builds/slave/test 19:21:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:21:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:25 INFO - {'append_to_log': False, 19:21:25 INFO - 'base_work_dir': '/builds/slave/test', 19:21:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:21:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:25 INFO - 'branch': 'Mozilla-Inbound', 19:21:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:25 INFO - 'config_files': ('talos/linux_config.py',), 19:21:25 INFO - 'default_actions': ('clobber', 19:21:25 INFO - 'read-buildbot-config', 19:21:25 INFO - 'download-and-extract', 19:21:25 INFO - 'populate-webroot', 19:21:25 INFO - 'create-virtualenv', 19:21:25 INFO - 'install', 19:21:25 INFO - 'run-tests'), 19:21:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:25 INFO - 'download_minidump_stackwalk': True, 19:21:25 INFO - 'download_symbols': 'ondemand', 19:21:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:25 INFO - 'installer_path': 'installer.exe', 19:21:25 INFO - 'log_level': 'info', 19:21:25 INFO - 'log_name': 'talos', 19:21:25 INFO - 'log_to_console': True, 19:21:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:25 INFO - 'opt_config_files': (), 19:21:25 INFO - 'pip_index': False, 19:21:25 INFO - 'sps_profile': False, 19:21:25 INFO - 'sps_profile_interval': 0, 19:21:25 INFO - 'suite': 'dromaeojs-e10s', 19:21:25 INFO - 'system_bits': '32', 19:21:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:25 INFO - 'title': 'talos-linux64-ix-001', 19:21:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:25 INFO - 'use_talos_json': True, 19:21:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:25 INFO - 'work_dir': 'build'} 19:21:25 INFO - ##### 19:21:25 INFO - ##### Running clobber step. 19:21:25 INFO - ##### 19:21:25 INFO - Running pre-action listener: _resource_record_pre_action 19:21:25 INFO - Running main action method: clobber 19:21:25 INFO - rmtree: /builds/slave/test/build 19:21:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:25 INFO - Running post-action listener: _resource_record_post_action 19:21:25 INFO - ##### 19:21:25 INFO - ##### Finished clobber step (success) 19:21:25 INFO - ##### 19:21:25 INFO - ##### 19:21:25 INFO - ##### Running read-buildbot-config step. 19:21:25 INFO - ##### 19:21:25 INFO - Running pre-action listener: _resource_record_pre_action 19:21:25 INFO - Running main action method: read_buildbot_config 19:21:25 INFO - Using buildbot properties: 19:21:25 INFO - { 19:21:25 INFO - "project": "", 19:21:25 INFO - "product": "firefox", 19:21:25 INFO - "script_repo_revision": "production", 19:21:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:21:25 INFO - "repository": "", 19:21:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:21:25 INFO - "buildid": "20160708163028", 19:21:25 INFO - "pgo_build": "True", 19:21:25 INFO - "basedir": "/builds/slave/test", 19:21:25 INFO - "buildnumber": 989, 19:21:25 INFO - "slavename": "talos-linux64-ix-001", 19:21:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:21:25 INFO - "platform": "ubuntu64_hw", 19:21:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:21:25 INFO - "branch": "mozilla-inbound", 19:21:25 INFO - "repo_path": "integration/mozilla-inbound", 19:21:25 INFO - "revision": "9ec9a9682d4680afa2d66281d518edb98908824f", 19:21:25 INFO - "stage_platform": "linux64-pgo", 19:21:25 INFO - "builduid": "7e684ce57b004e89b0920fe47e16f9b3", 19:21:25 INFO - "slavebuilddir": "test" 19:21:25 INFO - } 19:21:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:21:25 INFO - Running post-action listener: _resource_record_post_action 19:21:25 INFO - ##### 19:21:25 INFO - ##### Finished read-buildbot-config step (success) 19:21:25 INFO - ##### 19:21:25 INFO - ##### 19:21:25 INFO - ##### Running download-and-extract step. 19:21:25 INFO - ##### 19:21:25 INFO - Running pre-action listener: _resource_record_pre_action 19:21:25 INFO - Running main action method: download_and_extract 19:21:25 INFO - mkdir: /builds/slave/test/build/tests 19:21: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')]} 19:21:25 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:31 INFO - Downloaded 1361 bytes. 19:21:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:31 INFO - Using the following test package requirements: 19:21:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:21:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:21:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'jsshell-linux-x86_64.zip'], 19:21:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:21:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:21:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:21:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:21:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:21:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:21:31 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')]} 19:21:31 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:39 INFO - Downloaded 24307143 bytes. 19:21:39 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'] 19:21:39 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 19:21:40 INFO - Return code: 0 19:21:40 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 19:21:40 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')]} 19:21:40 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:41 INFO - Downloaded 24307143 bytes. 19:21:41 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'] 19:21:41 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 19:21:43 INFO - Return code: 0 19:21:43 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')]} 19:21:43 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:44 INFO - Downloaded 14403333 bytes. 19:21:44 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'] 19:21:44 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 19:21:44 INFO - Return code: 0 19:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:44 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:21:45 INFO - Downloaded 60458563 bytes. 19:21:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:45 INFO - mkdir: /builds/slave/test/properties 19:21:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:21:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:21:45 INFO - Contents: 19:21:45 INFO - build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:46 INFO - Running post-action listener: _resource_record_post_action 19:21:46 INFO - Running post-action listener: set_extra_try_arguments 19:21:46 INFO - ##### 19:21:46 INFO - ##### Finished download-and-extract step (success) 19:21:46 INFO - ##### 19:21:46 INFO - ##### 19:21:46 INFO - ##### Running populate-webroot step. 19:21:46 INFO - ##### 19:21:46 INFO - Running pre-action listener: _resource_record_pre_action 19:21:46 INFO - Running main action method: populate_webroot 19:21:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:21:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:21:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:21:46 INFO - '--tppagecycles', 19:21:46 INFO - '7'], 19:21:46 INFO - 'tests': ['tsvgm']}}, 19:21:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:21:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:21:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:21:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:21:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['damp', 'tps']}, 19:21:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'tests': ['damp', 'tps']}, 19:21:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['dromaeo_dom']}, 19:21:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:21:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['basic_compositor_video']}, 19:21:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:21:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['a11yr', 19:21:46 INFO - 'ts_paint', 19:21:46 INFO - 'tpaint', 19:21:46 INFO - 'sessionrestore', 19:21:46 INFO - 'sessionrestore_no_auto_restore', 19:21:46 INFO - 'tabpaint']}, 19:21:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['tsvgx', 19:21:46 INFO - 'tsvgr_opacity', 19:21:46 INFO - 'tart', 19:21:46 INFO - 'tscrollx', 19:21:46 INFO - 'cart']}, 19:21:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:21:46 INFO - 'tsvgr_opacity', 19:21:46 INFO - 'tart', 19:21:46 INFO - 'tscrollx', 19:21:46 INFO - 'cart']}, 19:21:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'talos_options': ['--disable-e10s'], 19:21:46 INFO - 'tests': ['tp5o']}, 19:21:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'tests': ['tp5o']}, 19:21:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'talos_options': ['--disable-e10s', 19:21:46 INFO - '--xperf_path', 19:21:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:46 INFO - 'tests': ['tp5n']}, 19:21:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:46 INFO - 'talos_options': ['--xperf_path', 19:21:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:46 INFO - 'tests': ['tp5n']}}, 19:21:46 INFO - 'talos.zip': {'path': '', 19:21:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:21:46 INFO - Running post-action listener: _resource_record_post_action 19:21:46 INFO - ##### 19:21:46 INFO - ##### Finished populate-webroot step (success) 19:21:46 INFO - ##### 19:21:46 INFO - ##### 19:21:46 INFO - ##### Running create-virtualenv step. 19:21:46 INFO - ##### 19:21:46 INFO - Running pre-action listener: _resource_record_pre_action 19:21:46 INFO - Running main action method: create_virtualenv 19:21:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:21:46 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 19:21:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:21:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:21:46 INFO - Using real prefix '/usr' 19:21:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:21:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:21:49 INFO - Installing pip.................done. 19:21:49 INFO - Return code: 0 19:21:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:49 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:21:49 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 19:21:49 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 19:21:49 INFO - Using env: {'DISPLAY': ':0', 19:21:49 INFO - 'HOME': '/home/cltbld', 19:21:49 INFO - 'LANG': 'en_US.UTF-8', 19:21:49 INFO - 'LANGUAGE': 'en_US:en', 19:21:49 INFO - 'LOGNAME': 'cltbld', 19:21:49 INFO - 'MAIL': '/var/mail/cltbld', 19:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:49 INFO - 'MOZ_NO_REMOTE': '1', 19:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:49 INFO - 'NO_EM_RESTART': '1', 19:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:49 INFO - 'PWD': '/builds/slave/test', 19:21:49 INFO - 'SHELL': '/bin/bash', 19:21:49 INFO - 'SHLVL': '1', 19:21:49 INFO - 'TERM': 'linux', 19:21:49 INFO - 'TMOUT': '86400', 19:21:49 INFO - 'USER': 'cltbld', 19:21:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:49 INFO - '_': '/tools/buildbot/bin/python'} 19:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:49 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 19:21:49 INFO - Cleaning up... 19:21:49 INFO - Return code: 0 19:21:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:49 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:21:49 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 19:21:49 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 19:21:49 INFO - Using env: {'DISPLAY': ':0', 19:21:49 INFO - 'HOME': '/home/cltbld', 19:21:49 INFO - 'LANG': 'en_US.UTF-8', 19:21:49 INFO - 'LANGUAGE': 'en_US:en', 19:21:49 INFO - 'LOGNAME': 'cltbld', 19:21:49 INFO - 'MAIL': '/var/mail/cltbld', 19:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:49 INFO - 'MOZ_NO_REMOTE': '1', 19:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:49 INFO - 'NO_EM_RESTART': '1', 19:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:49 INFO - 'PWD': '/builds/slave/test', 19:21:49 INFO - 'SHELL': '/bin/bash', 19:21:49 INFO - 'SHLVL': '1', 19:21:49 INFO - 'TERM': 'linux', 19:21:49 INFO - 'TMOUT': '86400', 19:21:49 INFO - 'USER': 'cltbld', 19:21:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:49 INFO - '_': '/tools/buildbot/bin/python'} 19:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:49 INFO - Downloading/unpacking psutil>=3.1.1 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:21:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:51 INFO - Installing collected packages: psutil 19:21:51 INFO - Running setup.py install for psutil 19:21:51 INFO - building 'psutil._psutil_linux' extension 19:21:51 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 19:21:51 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 19:21:51 INFO - building 'psutil._psutil_posix' extension 19:21:51 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 19:21:51 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 19:21:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:52 INFO - Successfully installed psutil 19:21:52 INFO - Cleaning up... 19:21:52 INFO - Return code: 0 19:21:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:21:52 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')]} 19:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:52 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')]} 19:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:52 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:21:52 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 19:21:52 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 19:21:52 INFO - Using env: {'DISPLAY': ':0', 19:21:52 INFO - 'HOME': '/home/cltbld', 19:21:52 INFO - 'LANG': 'en_US.UTF-8', 19:21:52 INFO - 'LANGUAGE': 'en_US:en', 19:21:52 INFO - 'LOGNAME': 'cltbld', 19:21:52 INFO - 'MAIL': '/var/mail/cltbld', 19:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:52 INFO - 'MOZ_NO_REMOTE': '1', 19:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:52 INFO - 'NO_EM_RESTART': '1', 19:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:52 INFO - 'PWD': '/builds/slave/test', 19:21:52 INFO - 'SHELL': '/bin/bash', 19:21:52 INFO - 'SHLVL': '1', 19:21:52 INFO - 'TERM': 'linux', 19:21:52 INFO - 'TMOUT': '86400', 19:21:52 INFO - 'USER': 'cltbld', 19:21:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:52 INFO - '_': '/tools/buildbot/bin/python'} 19:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:21:52 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 19:21:52 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 19:21:52 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 19:21:52 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 19:21:52 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 19:21:52 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 19:21:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:21:54 INFO - Installing collected packages: mozsystemmonitor 19:21:54 INFO - Running setup.py install for mozsystemmonitor 19:21:54 INFO - Successfully installed mozsystemmonitor 19:21:54 INFO - Cleaning up... 19:21:54 INFO - Return code: 0 19:21:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:54 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:21:54 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 19:21:54 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 19:21:54 INFO - Using env: {'DISPLAY': ':0', 19:21:54 INFO - 'HOME': '/home/cltbld', 19:21:54 INFO - 'LANG': 'en_US.UTF-8', 19:21:54 INFO - 'LANGUAGE': 'en_US:en', 19:21:54 INFO - 'LOGNAME': 'cltbld', 19:21:54 INFO - 'MAIL': '/var/mail/cltbld', 19:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:54 INFO - 'MOZ_NO_REMOTE': '1', 19:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:54 INFO - 'NO_EM_RESTART': '1', 19:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:54 INFO - 'PWD': '/builds/slave/test', 19:21:54 INFO - 'SHELL': '/bin/bash', 19:21:54 INFO - 'SHLVL': '1', 19:21:54 INFO - 'TERM': 'linux', 19:21:54 INFO - 'TMOUT': '86400', 19:21:54 INFO - 'USER': 'cltbld', 19:21:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:54 INFO - '_': '/tools/buildbot/bin/python'} 19:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:21:54 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 19:21:54 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 19:21:54 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 19:21:54 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 19:21:54 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 19:21:54 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 19:21:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:21:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:21:56 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 19:21:56 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 19:21:56 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 19:21:56 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 19:21:56 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 19:21:56 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 19:21:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:21:56 INFO - warning: no files found matching '*.txt' 19:21:56 INFO - no previously-included directories found matching 'build' 19:21:56 INFO - no previously-included directories found matching 'dist' 19:21:56 INFO - no previously-included directories found matching '.git*' 19:21:56 INFO - Installing collected packages: jsonschema, functools32 19:21:56 INFO - Running setup.py install for functools32 19:21:56 INFO - warning: no files found matching '*.txt' 19:21:56 INFO - no previously-included directories found matching 'build' 19:21:56 INFO - no previously-included directories found matching 'dist' 19:21:56 INFO - no previously-included directories found matching '.git*' 19:21:56 INFO - Successfully installed jsonschema functools32 19:21:56 INFO - Cleaning up... 19:21:56 INFO - Return code: 0 19:21:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:56 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:21:56 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 19:21:56 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 19:21:56 INFO - Using env: {'DISPLAY': ':0', 19:21:56 INFO - 'HOME': '/home/cltbld', 19:21:56 INFO - 'LANG': 'en_US.UTF-8', 19:21:56 INFO - 'LANGUAGE': 'en_US:en', 19:21:56 INFO - 'LOGNAME': 'cltbld', 19:21:56 INFO - 'MAIL': '/var/mail/cltbld', 19:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:56 INFO - 'MOZ_NO_REMOTE': '1', 19:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:56 INFO - 'NO_EM_RESTART': '1', 19:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:56 INFO - 'PWD': '/builds/slave/test', 19:21:56 INFO - 'SHELL': '/bin/bash', 19:21:56 INFO - 'SHLVL': '1', 19:21:56 INFO - 'TERM': 'linux', 19:21:56 INFO - 'TMOUT': '86400', 19:21:56 INFO - 'USER': 'cltbld', 19:21:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:56 INFO - '_': '/tools/buildbot/bin/python'} 19:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:21:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:21:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 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 19:21:59 INFO - Downloading docopt-0.6.1.tar.gz 19:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:21:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:21:59 INFO - Running setup.py install for blobuploader 19:21:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:21:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:21:59 INFO - Running setup.py install for requests 19:22:00 INFO - Running setup.py install for docopt 19:22:00 INFO - Successfully installed blobuploader requests docopt 19:22:00 INFO - Cleaning up... 19:22:00 INFO - Return code: 0 19:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:00 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:22:00 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 19:22:00 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 19:22:00 INFO - Using env: {'DISPLAY': ':0', 19:22:00 INFO - 'HOME': '/home/cltbld', 19:22:00 INFO - 'LANG': 'en_US.UTF-8', 19:22:00 INFO - 'LANGUAGE': 'en_US:en', 19:22:00 INFO - 'LOGNAME': 'cltbld', 19:22:00 INFO - 'MAIL': '/var/mail/cltbld', 19:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:00 INFO - 'MOZ_NO_REMOTE': '1', 19:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:00 INFO - 'NO_EM_RESTART': '1', 19:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:00 INFO - 'PWD': '/builds/slave/test', 19:22:00 INFO - 'SHELL': '/bin/bash', 19:22:00 INFO - 'SHLVL': '1', 19:22:00 INFO - 'TERM': 'linux', 19:22:00 INFO - 'TMOUT': '86400', 19:22:00 INFO - 'USER': 'cltbld', 19:22:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:00 INFO - '_': '/tools/buildbot/bin/python'} 19:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:00 INFO - Running setup.py (path:/tmp/pip-k5YBHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:00 INFO - Running setup.py (path:/tmp/pip-vGVeqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:00 INFO - Running setup.py (path:/tmp/pip-x5cPaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:00 INFO - Running setup.py (path:/tmp/pip-bMeBaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:00 INFO - Running setup.py (path:/tmp/pip-0FCKrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:00 INFO - Running setup.py (path:/tmp/pip-8_pC5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:01 INFO - Running setup.py (path:/tmp/pip-moXuDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:01 INFO - Running setup.py (path:/tmp/pip-wjSvyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:01 INFO - Running setup.py (path:/tmp/pip-r71AAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:01 INFO - Running setup.py (path:/tmp/pip-oJp1fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:01 INFO - Running setup.py (path:/tmp/pip-uof96T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:01 INFO - Running setup.py (path:/tmp/pip-wXcUsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:01 INFO - Running setup.py (path:/tmp/pip-4Daicm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:01 INFO - Running setup.py (path:/tmp/pip-dokKvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:01 INFO - Running setup.py (path:/tmp/pip-nh0QoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:01 INFO - Running setup.py (path:/tmp/pip-ue1J9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:01 INFO - Running setup.py (path:/tmp/pip-OVrAyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:22:01 INFO - Running setup.py install for manifestparser 19:22:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:22:01 INFO - Running setup.py install for mozcrash 19:22:02 INFO - Running setup.py install for mozdebug 19:22:02 INFO - Running setup.py install for mozdevice 19:22:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for mozfile 19:22:02 INFO - Running setup.py install for mozhttpd 19:22:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for mozinfo 19:22:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for mozInstall 19:22:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for mozleak 19:22:02 INFO - Running setup.py install for mozlog 19:22:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for moznetwork 19:22:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:22:02 INFO - Running setup.py install for mozprocess 19:22:03 INFO - Running setup.py install for mozprofile 19:22:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:22:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:22:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:22:03 INFO - Running setup.py install for mozrunner 19:22:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:22:03 INFO - Running setup.py install for mozscreenshot 19:22:03 INFO - Running setup.py install for moztest 19:22:03 INFO - Running setup.py install for mozversion 19:22:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:22:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:22:03 INFO - Cleaning up... 19:22:03 INFO - Return code: 0 19:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:03 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')]} 19:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:03 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')]} 19:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:03 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:22:03 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 19:22:03 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 19:22:03 INFO - Using env: {'DISPLAY': ':0', 19:22:03 INFO - 'HOME': '/home/cltbld', 19:22:03 INFO - 'LANG': 'en_US.UTF-8', 19:22:03 INFO - 'LANGUAGE': 'en_US:en', 19:22:03 INFO - 'LOGNAME': 'cltbld', 19:22:03 INFO - 'MAIL': '/var/mail/cltbld', 19:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:03 INFO - 'MOZ_NO_REMOTE': '1', 19:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:03 INFO - 'NO_EM_RESTART': '1', 19:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:03 INFO - 'PWD': '/builds/slave/test', 19:22:03 INFO - 'SHELL': '/bin/bash', 19:22:03 INFO - 'SHLVL': '1', 19:22:03 INFO - 'TERM': 'linux', 19:22:03 INFO - 'TMOUT': '86400', 19:22:03 INFO - 'USER': 'cltbld', 19:22:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:03 INFO - '_': '/tools/buildbot/bin/python'} 19:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:03 INFO - Running setup.py (path:/tmp/pip-b6y3XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:03 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)) 19:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:03 INFO - Running setup.py (path:/tmp/pip-YcrITc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:03 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)) 19:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:03 INFO - Running setup.py (path:/tmp/pip-EHNQE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:04 INFO - Running setup.py (path:/tmp/pip-JtK8kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:04 INFO - Running setup.py (path:/tmp/pip-auMSLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:04 INFO - Running setup.py (path:/tmp/pip-S42wlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:04 INFO - Running setup.py (path:/tmp/pip-PdHm9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:04 INFO - Running setup.py (path:/tmp/pip-FzXK4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:04 INFO - Running setup.py (path:/tmp/pip-e6QUNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:04 INFO - Running setup.py (path:/tmp/pip-vYdx34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:04 INFO - Running setup.py (path:/tmp/pip-0lWkqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:04 INFO - Running setup.py (path:/tmp/pip-92GHfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:04 INFO - Running setup.py (path:/tmp/pip-44hXzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:04 INFO - Running setup.py (path:/tmp/pip-5UENEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:04 INFO - Running setup.py (path:/tmp/pip-7cSW4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:04 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)) 19:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:04 INFO - Running setup.py (path:/tmp/pip-9P9dwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:05 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)) 19:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:05 INFO - Running setup.py (path:/tmp/pip-NhXz9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:05 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)) 19:22:05 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)) 19:22:05 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)) 19:22:05 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)) 19:22:05 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)) 19:22:05 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)) 19:22:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:06 INFO - Downloading blessings-1.6.tar.gz 19:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:22:07 INFO - Installing collected packages: blessings 19:22:07 INFO - Running setup.py install for blessings 19:22:07 INFO - Successfully installed blessings 19:22:07 INFO - Cleaning up... 19:22:07 INFO - Return code: 0 19:22:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:07 INFO - Reading from file tmpfile_stdout 19:22:07 INFO - Current package versions: 19:22:07 INFO - argparse == 1.2.1 19:22:07 INFO - blessings == 1.6 19:22:07 INFO - blobuploader == 1.2.4 19:22:07 INFO - docopt == 0.6.1 19:22:07 INFO - functools32 == 3.2.3-2 19:22:07 INFO - jsonschema == 2.5.1 19:22:07 INFO - manifestparser == 1.1 19:22:07 INFO - mozInstall == 1.12 19:22:07 INFO - mozcrash == 0.17 19:22:07 INFO - mozdebug == 0.1 19:22:07 INFO - mozdevice == 0.48 19:22:07 INFO - mozfile == 1.2 19:22:07 INFO - mozhttpd == 0.7 19:22:07 INFO - mozinfo == 0.9 19:22:07 INFO - mozleak == 0.1 19:22:07 INFO - mozlog == 3.2 19:22:07 INFO - moznetwork == 0.27 19:22:07 INFO - mozprocess == 0.23 19:22:07 INFO - mozprofile == 0.28 19:22:07 INFO - mozrunner == 6.12 19:22:07 INFO - mozscreenshot == 0.1 19:22:07 INFO - mozsystemmonitor == 0.3 19:22:07 INFO - moztest == 0.7 19:22:07 INFO - mozversion == 1.4 19:22:07 INFO - psutil == 3.1.1 19:22:07 INFO - requests == 1.2.3 19:22:07 INFO - wsgiref == 0.1.2 19:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:07 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 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:22:07 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 19:22:07 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 19:22:07 INFO - Using env: {'DISPLAY': ':0', 19:22:07 INFO - 'HOME': '/home/cltbld', 19:22:07 INFO - 'LANG': 'en_US.UTF-8', 19:22:07 INFO - 'LANGUAGE': 'en_US:en', 19:22:07 INFO - 'LOGNAME': 'cltbld', 19:22:07 INFO - 'MAIL': '/var/mail/cltbld', 19:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:07 INFO - 'MOZ_NO_REMOTE': '1', 19:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:07 INFO - 'NO_EM_RESTART': '1', 19:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:07 INFO - 'PWD': '/builds/slave/test', 19:22:07 INFO - 'SHELL': '/bin/bash', 19:22:07 INFO - 'SHLVL': '1', 19:22:07 INFO - 'TERM': 'linux', 19:22:07 INFO - 'TMOUT': '86400', 19:22:07 INFO - 'USER': 'cltbld', 19:22:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:07 INFO - '_': '/tools/buildbot/bin/python'} 19:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 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)) 19:22:07 INFO - Cleaning up... 19:22:07 INFO - Return code: 0 19:22:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', '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 19:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:22:07 INFO - Using env: {'DISPLAY': ':0', 19:22:07 INFO - 'HOME': '/home/cltbld', 19:22:07 INFO - 'LANG': 'en_US.UTF-8', 19:22:07 INFO - 'LANGUAGE': 'en_US:en', 19:22:07 INFO - 'LOGNAME': 'cltbld', 19:22:07 INFO - 'MAIL': '/var/mail/cltbld', 19:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:07 INFO - 'MOZ_NO_REMOTE': '1', 19:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:07 INFO - 'NO_EM_RESTART': '1', 19:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:07 INFO - 'PWD': '/builds/slave/test', 19:22:07 INFO - 'SHELL': '/bin/bash', 19:22:07 INFO - 'SHLVL': '1', 19:22:07 INFO - 'TERM': 'linux', 19:22:07 INFO - 'TMOUT': '86400', 19:22:07 INFO - 'USER': 'cltbld', 19:22:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:07 INFO - '_': '/tools/buildbot/bin/python'} 19:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:22:07 INFO - Cleaning up... 19:22:07 INFO - Return code: 0 19:22:07 INFO - Running post-action listener: _resource_record_post_action 19:22:07 INFO - Running post-action listener: _start_resource_monitoring 19:22:07 INFO - Starting resource monitoring. 19:22:07 INFO - ##### 19:22:07 INFO - ##### Finished create-virtualenv step (success) 19:22:07 INFO - ##### 19:22:07 INFO - ##### 19:22:07 INFO - ##### Running install step. 19:22:07 INFO - ##### 19:22:07 INFO - Running pre-action listener: _resource_record_pre_action 19:22:07 INFO - Running main action method: install 19:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:08 INFO - Reading from file tmpfile_stdout 19:22:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:22:08 INFO - Reading from file tmpfile_stdout 19:22:08 INFO - Output received: 19:22:08 INFO - Usage: mozinstall [options] installer 19:22:08 INFO - Options: 19:22:08 INFO - -h, --help show this help message and exit 19:22:08 INFO - -d DEST, --destination=DEST 19:22:08 INFO - Directory to install application into. [default: 19:22:08 INFO - "/builds/slave/test"] 19:22:08 INFO - --app=APP Application being installed. [default: firefox] 19:22:08 INFO - mkdir: /builds/slave/test/build/application 19:22:08 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'] 19:22:08 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 19:22:25 INFO - Reading from file tmpfile_stdout 19:22:25 INFO - Output received: 19:22:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:22:25 INFO - Running post-action listener: _resource_record_post_action 19:22:25 INFO - ##### 19:22:25 INFO - ##### Finished install step (success) 19:22:25 INFO - ##### 19:22:25 INFO - ##### 19:22:25 INFO - ##### Running run-tests step. 19:22:25 INFO - ##### 19:22:25 INFO - Running pre-action listener: _resource_record_pre_action 19:22:25 INFO - Running main action method: run_tests 19:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:22:25 INFO - Python 2.7.3 19:22:25 INFO - Return code: 0 19:22:25 INFO - grabbing minidump binary from tooltool 19:22: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')]} 19:22:25 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 0x2abc570>, '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 0x2abd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abd900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:22:25 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 19:22:25 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 19:22:25 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 19:22:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:22:25 INFO - Return code: 0 19:22:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:22:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:22:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:22:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:22:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 19:22:25 INFO - Using env: {'DISPLAY': ':0', 19:22:25 INFO - 'HOME': '/home/cltbld', 19:22:25 INFO - 'LANG': 'en_US.UTF-8', 19:22:25 INFO - 'LANGUAGE': 'en_US:en', 19:22:25 INFO - 'LOGNAME': 'cltbld', 19:22:25 INFO - 'MAIL': '/var/mail/cltbld', 19:22:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:22:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:25 INFO - 'MOZ_NO_REMOTE': '1', 19:22:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:25 INFO - 'NO_EM_RESTART': '1', 19:22:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:25 INFO - 'PWD': '/builds/slave/test', 19:22:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:22:25 INFO - 'SHELL': '/bin/bash', 19:22:25 INFO - 'SHLVL': '1', 19:22:25 INFO - 'TERM': 'linux', 19:22:25 INFO - 'TMOUT': '86400', 19:22:25 INFO - 'USER': 'cltbld', 19:22:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847', 19:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:25 INFO - '_': '/tools/buildbot/bin/python'} 19:22:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:22:25 INFO - mozversion application_buildid: 20160708163028 19:22:25 INFO - mozversion application_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:22:25 INFO - mozversion application_display_name: Nightly 19:22:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:22:25 INFO - mozversion application_name: Firefox 19:22:25 INFO - mozversion application_remotingname: firefox 19:22:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:22:25 INFO - mozversion application_vendor: Mozilla 19:22:25 INFO - mozversion application_version: 50.0a1 19:22:25 INFO - mozversion platform_buildid: 20160708163028 19:22:25 INFO - mozversion platform_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:22:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:22:25 INFO - mozversion platform_version: 50.0a1 19:22:25 INFO - using testdate: 1468030945 19:22:25 INFO - actual date: 1468030945 19:22:25 INFO - starting webserver on 'localhost:54018' 19:22:25 INFO - SUITE-START | Running 2 tests 19:22:25 INFO - TEST-START | dromaeo_css 19:22:25 INFO - operating with platform_type : linux_ 19:22:25 INFO - Initialising browser for dromaeo_css test... 19:22:25 INFO - TEST-INFO | started process 32170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2aZKG/profile http://localhost:54018/getInfo.html) 19:22:30 INFO - PROCESS | 32170 | __metrics Screen width/height:1600/1200 19:22:30 INFO - PROCESS | 32170 | colorDepth:24 19:22:30 INFO - PROCESS | 32170 | Browser inner width/height: 1024/697 19:22:30 INFO - PROCESS | 32170 | __metrics 19:22:31 ERROR - PROCESS | 32170 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 19:22:31 INFO - TEST-INFO | 32170: exit 0 19:22:31 INFO - Browser initialized. 19:22:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:22:31 INFO - TEST-INFO | started process 32294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2aZKG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:43 INFO - PROCESS | 32294 | RSS: Main: 167993344 19:22:43 INFO - PROCESS | 32294 | 19:23:33 INFO - PROCESS | 32294 | 1468031013319 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] 19:25:40 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54018/tests/dromaeo/cssquery-ext.html) 19:25:42 INFO - PROCESS | 32294 | RSS: Main: 170766336 19:25:42 INFO - PROCESS | 32294 | 19:28:44 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-ext.html (next: http://localhost:54018/tests/dromaeo/cssquery-jquery.html) 19:28:44 INFO - PROCESS | 32294 | RSS: Main: 168271872 19:28:44 INFO - PROCESS | 32294 | 19:31:46 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54018/tests/dromaeo/cssquery-mootools.html) 19:31:47 INFO - PROCESS | 32294 | RSS: Main: 171884544 19:31:47 INFO - PROCESS | 32294 | 19:34:49 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54018/tests/dromaeo/cssquery-prototype.html) 19:34:49 INFO - PROCESS | 32294 | RSS: Main: 166731776 19:34:49 INFO - PROCESS | 32294 | 19:37:52 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54018/tests/dromaeo/cssquery-yui.html) 19:37:52 INFO - PROCESS | 32294 | RSS: Main: 169127936 19:37:52 INFO - PROCESS | 32294 | 19:40:55 INFO - PROCESS | 32294 | Cycle 1(1): loaded http://localhost:54018/tests/dromaeo/cssquery-yui.html (next: http://localhost:54018/tests/dromaeo/cssquery-dojo.html) 19:40:56 INFO - PROCESS | 32294 | RSS: Main: 170020864 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | __start_tp_report 19:40:56 INFO - PROCESS | 32294 | _x_x_mozilla_page_load 19:40:56 INFO - PROCESS | 32294 | _x_x_mozilla_page_load_details 19:40:56 INFO - PROCESS | 32294 | |i|pagename|runs| 19:40:56 INFO - PROCESS | 32294 | |0;dojo.html;3061.0357737312743;3083.352495975845;3108.953365699514;3117.3921085388342;3118.501039833626;5367.543758780504;5402.324709411324;5421.996930567842;5490.149026900826;5498.367687715914;5358.223057656637;5381.300430943972;5424.593155513333;5495.890082198353;5579.7489112989915;4862.951370486294;4887.095887260868;4966.602671786267;5021.497850214986;5062;738.0160419899204;4860.076585448754;4907.803687852482;4957.3059771632;4957.776900039489;4950.504949505057;4986.376702912136;4987.226979818134;4991.251312303166;4995.35060442142;4976.776045077981;4981.701097934136;4997.100521906055;4997.12550303699;5039.193729003378;4857.441394239672;4911.754412279408;4931.112399768041;4934.703917764946;4939.777710003059;5443.237946687427;5446.21029950655;5487.780488780444;5493.505584497374;5514.641548299388;5651.7739290428335;5716.028275193227;5862.062070068769;5867.941320586782;5891.145783861316;5752.252207213036;5792.623479473821;5793;5818.912716309259;5857.033589457735;5417.10617748075;5419.051665958442;5423.593230507728;5431.755570999315;5441.29263195786;5883.205767221456;5902.527797776168;5910.083936989773;5936.406359364029;5957.582969192115;5681.517071048925;5689.743961521742;5690.971545142248;5692.260006199168;5694.06048002075;5815.563832712563;5816.360200377955;5818.243628328375;5819.5053420459735;5823;5730.885382292331;5756.251687280626;5789.94210057894;5792.304923409218;5800.564957628195;5778.162166485836;5790.276215473066;5794.072948328248;5794.21778059965;5795.478406943395;4381.6494680425485;4433.334999749999;4447.2439685253585;4452.821887124479;4496.437945256843;3879.0690234343556;3913.5890731473355;3943.369060950234;3947.6644485219076;3954.5254569451276;5497.725113744297;5534.667919924817;5585.1901474286005;5630.60585758993;5636.0982242841765;5772.7113644317615;5855.414458554111;5905.734241959122;5908.793192238251;5910.202122713465;5581.776728930879;5631.380548139701;5639.718014099279;5650.943490565041;5669.659820410789;5026.623003274769;5087.796488140433;5089.160288552422;5112.207607820794;5154.098032844312;5890.911636325459;5945.375735547792;6145.293291271561;6152.077188421683;6157.8460538486;5813.2442782437165;5831.533477321719;5845.09401042839;5874.706264686663;5913.911291330547;6060.6969651516365;6065.120557519047;6072.483838873745;6074.42292982166;6076.997295446202;5623.8875222496135;5693.146028095819;5764.538836893123;5765.1928729977;5766.682832444256;5834.533237341087;5841.561882858718;5860.267466566679;5875.529957603296;5900.1149827526215;5657.3776884543495;5668.433156684298;5707.771689132388;5726.255586773693;5728.398518155534;5552.361478429871;5559;5580.665160090408;5635.633683810539;5693.715314234355;5599.412061733622;5613;5622.803201887914;5624.718764061862;5661.179129026351;5649.971750141223;5660.773569057192;5678.630888992202;5694.601377903507;5705.515031222392;5548.750306236309;5552.444755524415;5572.609917305912;5572.749226284908;5603.327600687943 19:40:56 INFO - PROCESS | 32294 | |1;ext.html;546.3763677637942;583.3291714528294;596.8328867916983;608.2670382189463;635.7933671556746;41909.79045104774;42923.35614965778;45332.999999999956;45715.08569828601;45761.084778304416;45845.54154458454;46820.063598728004;46827.76586117064;46964;47025.529744702544;8883.51140687262;9070;9092.8636070459;9109.544522773867;9118.133777291147;8844.07137250589;8891.288696904232;8938.1508756668;8941.821163576724;8960.820783584324;8971.685990990316;9016.68441604544;9018.639254429814;9023.909760902405;9041.457512549268;8930.776730581754;8955.059718729537;8960.417572857743;8981.101889811032;8995.100489950984;8888.288936885034;8921.884764404449;8950.239229665487;8991.100889911022;8997.055309192507;43739.34390984138;44165.337519937224;44223.77888110571;44253.336199957026;44273.33589996152;2966.362232120083;3466.4626982817704;3516.894493165209;3609.693176080036;3663.908402289964;32084.79152084796;32754.836225818955;32768;34040.127792971376;35023.299534009435;4494.70784399013;4517.41482395369;4553.704009239389;4565.840195593139;4743.928841067387;364720;365199;367170;367769;370235.14882425684;61592.384076159564;61805.381946179965;61996.69001655053;62002.379976200566;62040.68979655163;36180.27639447196;36827.26345473075;36937.81531092327;38634.227315453536;65079.34920650733;17205.82794172042;17249.137543122793;17254.792164548613;17316.826831731774;17407.47777566675;13225.404856781468;13283;13424.926005919502;13446.596602101952;13485.66285842842;20085.39743807688;20100.296489622793;20115.29596464117;20120.597588048156;20197;7409.333160015624;7543.358814500719;7549.131849837229;7643.4267429942975;7721.884171737428;966;968.9176420004237;1065.6376831877199;1074.1267110479437;1164.9009834164021;31566.842165789025;33931.83034084814;34004;34093.318133637185;34280.82859585686;1168.0888906652824;1184.2953442701578;1217.6225370135287;1221.4808706299964;1283.9550615728592;17193.65612687739;17222.913885430742;17238;17441.49052514354;17487.30050797979;611390;613952;618537;619316;623772;60800;61603.6919815407;61899;61940.38059619346;62052.68973655193;1325.5294370498334;1350.3653282956996;1371.403439503819;1380.2753554383828;1390.1728471559609;32218;33018;33281.334373312886;33382.66617333796;33596.79859839141;51670;52378.214326784364;52826.47173528215;52969;53076;506467;508106;509213;512375;512490;29098.39958802286;46672.766636166605;47078;47926;48375;49592.504074960234;49992;51086.48913510966;53462.465375345746;54161;44847.77576112099;45102.54897450984;45458.13290174997;45558.54441455675;47303;44468.55531444644;44551;45079.32381014222;45593;46232.30651540297;37477.4378384319;44247;44261.77869110634;45052.32421513746;45341.31988020116;37856.810715946245;39694.80152599334;39968.4004739935;40040;41124;29956.700432996262;30539;30688.539671905386;30796.846015769777;30959.226019349695 19:40:56 INFO - PROCESS | 32294 | |2;jquery.html;390.1747803395817;396.988090357289;398.1241269207743;398.9301872172371;419.2139737991266;16580;19101.23595056198;19538.90230548849;20675.069621867035;20738.688919666216;18851.52871178221;19305.227790888348;19368.709469357935;19453.513662158453;19468.610627787435;5670.0927851543765;5772.711364431782;5776.855578610526;5777.971110144444;5801.535877129841;5575.609707320489;5670.319561652607;5673.971630141844;5763.193152958589;5777.768889244425;5487.314085739283;5673.063944449161;5687.488126068653;5689.6017278790505;5693.800716974907;5573.832785016456;5617.606767526275;5630.352509461403;5648.74580643872;5674.177244299594;5006.69959802413;5114.079465696173;5133.51231632998;5146.3824341078935;5159.922601160985;22408.887955560116;22876.542469150525;23319.41701457477;23529.41176470585;23571.528569428687;2340.578695834749;2469.09877894569;2587.3531617095728;2594.5848664213822;2628.4743051389605;14124.92937535316;14908.62728431798;15023.09861408319;15035.849641503664;15209.315580798891;1859.172668162668;1920.836728878047;1989.3634037108131;2024.4331587155473;2044;70979.64510177416;73923;74025;80038.59980700117;83057.58471207666;10766.354018758899;11095.167862410352;11123.443827808576;11258.718532036764;11287.717807054889;12245.816312755316;13026.41381137851;13090.607281781562;15284.38862445512;15483.458078967182;7749.651265693057;7794;8125.1062383137805;8188.590570471452;8233.670653173926;8144;8184.54984975832;8185.467944583702;8351.457155284887;8358.540280284522;4053.7162398631813;4066.8373265069067;4118.814653340607;4213.747175169499;4234.724742891703;1843.4653950354516;1886.8962207078741;1957.667196576557;1998.7801341852385;2060.5054786851047;959.2182371367313;976.4434272464769;987.7652933832709;1041.8124737547162;1064.7178497698117;19084.809151908303;19469.415917522496;19698.50753731168;19880.50298742543;19906.104225309897;1004.3672486333563;1022.3303736052898;1026.650938680852;1036.3315661398356;1056.3081181825917;10661.84007239892;10939;11064.170187235828;11086.61196858106;11087.113030957504;484232;489153;489809;490671;490945;89649.55175224082;91523.54238228766;93410;97707;98921;1008.9192864570816;1053.5259133390005;1055.3931489393628;1058.0583280880023;1067.4502631144967;17555.473335799947;17689.38087166943;18243.361482348053;18306.633867322846;18329.3584724534;43078.846057697614;43313.783431082644;43853.12293754171;44558.77720611376;44644.55355446534;63338;63970.36029639644;64897.35102648913;64978.35021649723;65628;8652.913470865211;8787.121287871161;8873.73704839739;8951.865722014305;9045.140711632384;13073.673158171121;13763.655908602364;14085.295735212994;14384.856151438771;14462.421503139756;11862.40687965581;12041.45813438415;12499.750004999667;12760.361981901053;12795;12034.097442692007;12173.634790955932;12262;12712.872871271169;12798.16811907223;6188.81433556994;11751.236169648946;12538.498460061495;12603.68490787701;12647.177933434297;7763.107242667165;7823.647935843014;8087.757367278991;8764.91235087641;8944.150305720947;8596.871046934177;11301.491432885376;12069.637910862688;12438.502459901503;12438.626841194779 19:40:56 INFO - PROCESS | 32294 | |3;mootools.html;1448.8551144885512;1479.4082367053181;1611.1299898055051;1770.9645807083866;1777.2890843662526;7424.814379640512;8272.793180170498;8273.214044665747;8751.91248087519;8758.12418758124;8333.374996875229;8557.22984931356;8657.177568131034;8665.95667021664;8668.436551624156;2273.2839155665997;2311.653252012195;2311.699479067719;2316.81465482761;2317.6986991691056;2253.853499522534;2256.6050941085327;2294.242899843048;2294.3919861236786;2315.8263130265213;2273.2952784636814;2290.1297506947335;2293.2546922250335;2319.22306027481;2321.210788331967;2245.247841972941;2258.006477150057;2267.682524446579;2273;2281.315605318398;1904.4667493101954;1940.9708854367195;1948.2888745607752;1951.863369564131;1953.1796645408963;8559.400841941067;8575.785605359915;8583.356248281403;8623.223909848144;8630.395872288942;4943.134951383529;5064.442911279756;5076.340075790161;5076.619253555961;5088.872778180538;3047.4666933286585;3157.7947433416984;3189.856456459465;3212.9236705703615;3216.8713251469912;1042.7601651620093;1069.8288273876142;1090.6837017264984;1105.850710154127;1105.9612913548067;11187.160962927814;11482.655520334403;11494.770104597945;11668.299902005907;11704.88295117055;4199.4120823084795;4355.5208927018;4387.978060109743;4434.046679963823;4447.933281000787;9145.222656074175;9173.862392064124;9196;9209.585568649427;9215.861762073575;5107.284980102789;5116.309298244763;5121.334226550524;5123.231515272664;5125.743712814345;4257.787110644517;4612.7462989535225;4697.13103075932;4724.031573527419;4775.235962246094;3563.2873425314524;3591.712662986955;3657.23198128396;3703.4259689748133;3705.166337574078;1109.5506319940437;1119.0655802405083;1129.2829053551054;1131.9547218111347;1137.3176094343328;793.4882001109253;947.725159703692;952.7760976170595;970.3256236915418;1007.5818535307765;5908.291005079418;5929.347771745104;5933.110033494924;6085.939140608537;6238.906416403757;423.8347044652588;434.2227412930882;451.2126339537528;455.760725619046;456.0878243512974;4124.587541245852;4166.291730405838;4184.497860256789;4189.329707246826;4202.243596152722;9960.103590676874;10246.948765256126;10309.84535231972;10316.48417579118;10331.276810623183;10154.644587439405;10207.285490015627;10250.436226007641;10256.538455769509;10265.897341026643;7610.200928902385;7911.12977572455;7939.920600794034;7943.165967573322;7943.801404964922;6095.786647467317;6225.750969961151;6336.998696722823;6359.491240700825;6428.774992875227;9629.229661627192;9852.901470985486;9858.063483969012;9931.453770042717;9946.104850563195;9475.620975161191;9814.214862810815;10025.398476091457;10100.696979090639;10134;6775.966120169368;7565.092188937363;7640.73257435987;7740.729074482591;7892.723754668559;8231.34149268069;8422.031466381199;8471.872921906053;8481;8505.277051450696;7389;7582.203868593939;7604.505707129019;7684.692612295669;7706.845863082819;7209.747658832125;7472.476926615085;7575.621218938921;7578.12851522082;7641.350485208597;6931.306869313028;6969.6515174242095;7038.718451261892;7043.718251269892;7057.50597458173;5187.1181899078;5326.440723723953;5424.186372044225;5450.155225939986;5466.535344495763;5169.638125331341;5191.584673226057;5296.629235953446;5352.090144675337;5446.918296225481 19:40:56 INFO - PROCESS | 32294 | |4;prototype.html;278.36532705431625;299.82160614434406;299.94301082794266;305.9648140463847;309.66710785905155;5379.9731001344935;5490.890182196354;5569.359523654781;5665.348484924235;5689.544836413087;5530.5852061095375;5544.390117087117;5548.55611551076;5549.750261238244;5571.164325351199;4328.826846926119;4355.673324500659;4355.716878402894;4376.737395756265;4388.692791504596;4071.8982025449454;4255.319148936168;4257.531671516131;4364.323529852878;4382.386465894777;4210.768407737573;4219.8606376278385;4231.196072746168;4247.108107297471;4259.6805239607;4261.339492378686;4267.957320426787;4271.829126834954;4279.239890270789;4284.2930916398755;3509.982450087759;3704.8888533343775;3706.8517259309597;3708.5178926739623;3724.3296206682785;5376.51611354976;5427.348718153847;5433.994710978482;5440.6735595863975;5468.179773034037;4863.781129849165;4884.436980166348;4930.827421040282;4941.654084214107;4949.975250123763;5585.804496842632;5851.3270973838125;5855.272694555117;5862.20860183874;5898.941010589882;4089.5501494835544;4096.815643296029;4109.260333140033;4129.256733787917;4131.462909821734;6115.296740874812;6147.78482753106;6152.723127459275;6161.260648722137;6238.625682459022;4055.8986025349013;4096.344584866407;4096.569860164699;4198.971252043269;4219.51475580306;4097.2010457961005;4109.609587089221;4122.2786012447705;4122.856114820277;4155.148194620156;4809.663323567317;4820.084184005028;4839.2983017462275;4859.3759369939835;4860.684055536379;5735.971320143456;5880.882382352329;5954.612950158225;5957.4042595740075;5964.373740757244;1440.5750303660445;1447;1452.2593477326639;1462.2542503323168;1462.7293950619169;871.1375738019442;891.2379915172435;915.8992510823804;935.9157675809209;946.947917864524;4999.225120106389;5037.244413338029;5047.873803154877;5050.84847454577;5060.51925067118;5289.677580604849;5328.387235467893;5346.406992608581;5371.167469042305;5376.220448035013;4984.950150498521;5018.749062546858;5077.974610126926;5330.92003619946;5762.30852297727;3206.631237407728;3225.6290526589273;3233.7251333636905;3247.675232476781;3253.170441537393;6151.692415379213;6232.283287421914;6263.592866463665;6288.937110628835;6293.370662933761;6107.938920610737;6140.280721398016;6144.600600960924;6146.385361463817;6192.628442293477;6233.657148856766;6306.65313407767;6310.242770867433;6316.463100636497;6318.241810982619;5894.557908156819;6069.241344831896;6079.969600151971;6092.543059270483;6122.5408094392205;5920.703964801656;5920.911186332122;6000.5799594028;6015;6077;5989.3711160329285;6263;6276.399518122849;6310.286576771849;6350.1109844622715;4237.5762423758615;4268.743875367488;4270.765107919095;4271.081717430768;4283.7001409901;6190.350013248544;6198.876022479435;6200.503959683124;6206.813795586139;6210.658413787285;5752.453516916054;5995.220621319375;5996.310424301087;6017.849553761191;6072.787452439144;5967.880642387215;5968.850778730566;5969.283685957713;5993.310769261417;6010.909836352371;5690.544756419394;5938.524918006463;5989.670568118795;5996.691273859683;6006.87986240264;5948.910766338595;5981.641101533922;5986.653003074273;5988.6706231157705;6002.3097343804275;5908.468237858441;5915.526757859275;5918.993771058844;5920.200772895604;5924.9703751480965 19:40:56 INFO - PROCESS | 32294 | |5;yui.html;726.4624178108195;738.8670039392908;745.0575022596416;803.1647087029489;864.2696921101668;15445.227738613066;16140.112293823835;16486.83513164868;16648.66702665949;16659.66680666386;14113.223772692498;14183.149011059344;14190.645233869158;14226.573202803907;14297.857021429783;654.8624788794335;786.5634572812087;799.9520028798262;806.4556424413527;819.0417211862106;814.4461765999118;814.5357146426539;816.0411516468156;817.2236375443323;819.4059307002406;868.956552172392;872.9825403491926;876.0188588780575;878.5080355001188;878.5431575580694;865.6537385045968;866.4757821517985;866.9609867555976;867.7353407210799;870.0472982084607;634.175571756719;635.7139287320724;636.4176778247944;637.6684124255361;638.7157714816908;13281;13354.799678004838;13356.465741370333;13391.531296404579;13410.93294533531;14346.28268586577;14524.70950580993;14659.92670036643;14723.190224537646;14751.631209219748;12617.36155315083;12715.237085774883;12796.61610151697;13002.479900803957;13025.739485210242;3913.236918800835;3955.8615448459454;4031.3549832026733;4109.198706252282;4113.300738874369;74631.25368746297;75654;75888;76081.61959190224;79019.81470278007;12201;12345.197562158432;12493.93753031229;12522.311272880079;12737.172083814523;23657.52684946326;23679.1712290069;23692.763072369056;23701.644475332883;23707.28878133659;8709.477431354138;8903.421277617064;9172.357934944623;9186.173244407903;9404.576794044284;4757.95242047582;4838.080764654775;4874.293227482066;4960.0575890581395;4980.850574482772;3565.8217089145437;3652.652997965189;3672.8163591820303;3674.9448758268645;3675.5589329280124;608.2002167150183;623.4445059576295;630.9779157729457;635.0664523150961;637.3339859846471;622.1414448061646;677.2672267401014;695.4957655699678;739.9408047356198;755.2221212151493;9937.453440060866;10017.348872323275;10109.39343639384;10350.637727679496;10364.689059328231;678.328454829715;710.1939298895791;716.7527203114917;720.0854914258862;730.5065904398996;4742.786574604151;4795.352627395327;4902.215645496774;4904.215325547895;4959.652824302337;96573.5171324139;110372;115990.10024749448;122188.38905805413;123186.14510839111;101253;103730;103797;104724;105575.47212264044;84344;84455.57772210977;89664.5516772425;91555;91746.54126729457;9870.210383169473;9969.40183588987;10093.343932644648;10124.139448146696;10255.435951022766;51230.23154652608;51608.74195628998;51872;51959;52486.737566311924;53407.73296133494;77950;78293.60853195697;78331;81097;12057;12406.875931240933;12586.886349684111;12719.682007949505;13034.47862085506;15030.699386012437;15241.161736104621;15370.462033828762;15431.382744690087;16051.117188554741;13313.800292995806;13487.865121348661;13626.523071692443;13680.863191368357;13728;13309.201447913156;13354.399052042876;13459.663508412368;14031.228282444563;14137.151770893779;13809.171449713049;13945.930270348988;14207.857921421068;14433.92783036078;14854.77717834255;10268.024537668909;10757.784844302914;10872.61945831892;10930.125589952944;10971.156811827834;10739.785204296026;11031.724206894893;11051.336919784517;11140.498677559368;11211.439428028729 19:40:56 INFO - PROCESS | 32294 | __end_tp_report 19:40:56 INFO - PROCESS | 32294 | __start_cc_report 19:40:56 INFO - PROCESS | 32294 | _x_x_mozilla_cycle_collect,359 19:40:56 INFO - PROCESS | 32294 | __end_cc_report 19:40:56 INFO - PROCESS | 32294 | __startTimestamp1468032056089__endTimestamp 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | ------- Summary: start ------- 19:40:56 INFO - PROCESS | 32294 | Number of tests: 6 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#0] dojo.html Cycles:165 Average:5385.02 Median:5631.38 stddev:719.59 (12.8%) stddev-sans-first:698.32 19:40:56 INFO - PROCESS | 32294 | Values: 3061.0 3083.4 3109.0 3117.4 3118.5 5367.5 5402.3 5422.0 5490.1 5498.4 5358.2 5381.3 5424.6 5495.9 5579.7 4863.0 4887.1 4966.6 5021.5 5062.0 738.0 4860.1 4907.8 4957.3 4957.8 4950.5 4986.4 4987.2 4991.3 4995.4 4976.8 4981.7 4997.1 4997.1 5039.2 4857.4 4911.8 4931.1 4934.7 4939.8 5443.2 5446.2 5487.8 5493.5 5514.6 5651.8 5716.0 5862.1 5867.9 5891.1 5752.3 5792.6 5793.0 5818.9 5857.0 5417.1 5419.1 5423.6 5431.8 5441.3 5883.2 5902.5 5910.1 5936.4 5957.6 5681.5 5689.7 5691.0 5692.3 5694.1 5815.6 5816.4 5818.2 5819.5 5823.0 5730.9 5756.3 5789.9 5792.3 5800.6 5778.2 5790.3 5794.1 5794.2 5795.5 4381.6 4433.3 4447.2 4452.8 4496.4 3879.1 3913.6 3943.4 3947.7 3954.5 5497.7 5534.7 5585.2 5630.6 5636.1 5772.7 5855.4 5905.7 5908.8 5910.2 5581.8 5631.4 5639.7 5650.9 5669.7 5026.6 5087.8 5089.2 5112.2 5154.1 5890.9 5945.4 6145.3 6152.1 6157.8 5813.2 5831.5 5845.1 5874.7 5913.9 6060.7 6065.1 6072.5 6074.4 6077.0 5623.9 5693.1 5764.5 5765.2 5766.7 5834.5 5841.6 5860.3 5875.5 5900.1 5657.4 5668.4 5707.8 5726.3 5728.4 5552.4 5559.0 5580.7 5635.6 5693.7 5599.4 5613.0 5622.8 5624.7 5661.2 5650.0 5660.8 5678.6 5694.6 5705.5 5548.8 5552.4 5572.6 5572.7 5603.3 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#1] ext.html Cycles:180 Average:66136.42 Median:24925.21 stddev:135252.68 (542.6%) stddev-sans-first:135542.45 19:40:56 INFO - PROCESS | 32294 | Values: 546.4 583.3 596.8 608.3 635.8 41909.8 42923.4 45333.0 45715.1 45761.1 45845.5 46820.1 46827.8 46964.0 47025.5 8883.5 9070.0 9092.9 9109.5 9118.1 8844.1 8891.3 8938.2 8941.8 8960.8 8971.7 9016.7 9018.6 9023.9 9041.5 8930.8 8955.1 8960.4 8981.1 8995.1 8888.3 8921.9 8950.2 8991.1 8997.1 43739.3 44165.3 44223.8 44253.3 44273.3 2966.4 3466.5 3516.9 3609.7 3663.9 32084.8 32754.8 32768.0 34040.1 35023.3 4494.7 4517.4 4553.7 4565.8 4743.9 364720.0 365199.0 367170.0 367769.0 370235.1 61592.4 61805.4 61996.7 62002.4 62040.7 36180.3 36827.3 36937.8 38634.2 65079.3 17205.8 17249.1 17254.8 17316.8 17407.5 13225.4 13283.0 13424.9 13446.6 13485.7 20085.4 20100.3 20115.3 20120.6 20197.0 7409.3 7543.4 7549.1 7643.4 7721.9 966.0 968.9 1065.6 1074.1 1164.9 31566.8 33931.8 34004.0 34093.3 34280.8 1168.1 1184.3 1217.6 1221.5 1284.0 17193.7 17222.9 17238.0 17441.5 17487.3 611390.0 613952.0 618537.0 619316.0 623772.0 60800.0 61603.7 61899.0 61940.4 62052.7 1325.5 1350.4 1371.4 1380.3 1390.2 32218.0 33018.0 33281.3 33382.7 33596.8 51670.0 52378.2 52826.5 52969.0 53076.0 506467.0 508106.0 509213.0 512375.0 512490.0 29098.4 46672.8 47078.0 47926.0 48375.0 49592.5 49992.0 51086.5 53462.5 54161.0 44847.8 45102.5 45458.1 45558.5 47303.0 44468.6 44551.0 45079.3 45593.0 46232.3 37477.4 44247.0 44261.8 45052.3 45341.3 37856.8 39694.8 39968.4 40040.0 41124.0 29956.7 30539.0 30688.5 30796.8 30959.2 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#2] jquery.html Cycles:180 Average:29299.25 Median:13020.31 stddev:80660.26 (619.5%) stddev-sans-first:80857.32 19:40:56 INFO - PROCESS | 32294 | Values: 390.2 397.0 398.1 398.9 419.2 16580.0 19101.2 19538.9 20675.1 20738.7 18851.5 19305.2 19368.7 19453.5 19468.6 5670.1 5772.7 5776.9 5778.0 5801.5 5575.6 5670.3 5674.0 5763.2 5777.8 5487.3 5673.1 5687.5 5689.6 5693.8 5573.8 5617.6 5630.4 5648.7 5674.2 5006.7 5114.1 5133.5 5146.4 5159.9 22408.9 22876.5 23319.4 23529.4 23571.5 2340.6 2469.1 2587.4 2594.6 2628.5 14124.9 14908.6 15023.1 15035.8 15209.3 1859.2 1920.8 1989.4 2024.4 2044.0 70979.6 73923.0 74025.0 80038.6 83057.6 10766.4 11095.2 11123.4 11258.7 11287.7 12245.8 13026.4 13090.6 15284.4 15483.5 7749.7 7794.0 8125.1 8188.6 8233.7 8144.0 8184.5 8185.5 8351.5 8358.5 4053.7 4066.8 4118.8 4213.7 4234.7 1843.5 1886.9 1957.7 1998.8 2060.5 959.2 976.4 987.8 1041.8 1064.7 19084.8 19469.4 19698.5 19880.5 19906.1 1004.4 1022.3 1026.7 1036.3 1056.3 10661.8 10939.0 11064.2 11086.6 11087.1 484232.0 489153.0 489809.0 490671.0 490945.0 89649.6 91523.5 93410.0 97707.0 98921.0 1008.9 1053.5 1055.4 1058.1 1067.5 17555.5 17689.4 18243.4 18306.6 18329.4 43078.8 43313.8 43853.1 44558.8 44644.6 63338.0 63970.4 64897.4 64978.4 65628.0 8652.9 8787.1 8873.7 8951.9 9045.1 13073.7 13763.7 14085.3 14384.9 14462.4 11862.4 12041.5 12499.8 12760.4 12795.0 12034.1 12173.6 12262.0 12712.9 12798.2 6188.8 11751.2 12538.5 12603.7 12647.2 7763.1 7823.6 8087.8 8764.9 8944.2 8596.9 11301.5 12069.6 12438.5 12438.6 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#3] mootools.html Cycles:180 Average:5602.40 Median:5076.48 stddev:3157.59 (62.2%) stddev-sans-first:3151.02 19:40:56 INFO - PROCESS | 32294 | Values: 1448.9 1479.4 1611.1 1771.0 1777.3 7424.8 8272.8 8273.2 8751.9 8758.1 8333.4 8557.2 8657.2 8666.0 8668.4 2273.3 2311.7 2311.7 2316.8 2317.7 2253.9 2256.6 2294.2 2294.4 2315.8 2273.3 2290.1 2293.3 2319.2 2321.2 2245.2 2258.0 2267.7 2273.0 2281.3 1904.5 1941.0 1948.3 1951.9 1953.2 8559.4 8575.8 8583.4 8623.2 8630.4 4943.1 5064.4 5076.3 5076.6 5088.9 3047.5 3157.8 3189.9 3212.9 3216.9 1042.8 1069.8 1090.7 1105.9 1106.0 11187.2 11482.7 11494.8 11668.3 11704.9 4199.4 4355.5 4388.0 4434.0 4447.9 9145.2 9173.9 9196.0 9209.6 9215.9 5107.3 5116.3 5121.3 5123.2 5125.7 4257.8 4612.7 4697.1 4724.0 4775.2 3563.3 3591.7 3657.2 3703.4 3705.2 1109.6 1119.1 1129.3 1132.0 1137.3 793.5 947.7 952.8 970.3 1007.6 5908.3 5929.3 5933.1 6085.9 6238.9 423.8 434.2 451.2 455.8 456.1 4124.6 4166.3 4184.5 4189.3 4202.2 9960.1 10246.9 10309.8 10316.5 10331.3 10154.6 10207.3 10250.4 10256.5 10265.9 7610.2 7911.1 7939.9 7943.2 7943.8 6095.8 6225.8 6337.0 6359.5 6428.8 9629.2 9852.9 9858.1 9931.5 9946.1 9475.6 9814.2 10025.4 10100.7 10134.0 6776.0 7565.1 7640.7 7740.7 7892.7 8231.3 8422.0 8471.9 8481.0 8505.3 7389.0 7582.2 7604.5 7684.7 7706.8 7209.7 7472.5 7575.6 7578.1 7641.4 6931.3 6969.7 7038.7 7043.7 7057.5 5187.1 5326.4 5424.2 5450.2 5466.5 5169.6 5191.6 5296.6 5352.1 5446.9 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#4] prototype.html Cycles:180 Average:4890.36 Median:5510.74 stddev:1485.09 (26.9%) stddev-sans-first:1448.35 19:40:56 INFO - PROCESS | 32294 | Values: 278.4 299.8 299.9 306.0 309.7 5380.0 5490.9 5569.4 5665.3 5689.5 5530.6 5544.4 5548.6 5549.8 5571.2 4328.8 4355.7 4355.7 4376.7 4388.7 4071.9 4255.3 4257.5 4364.3 4382.4 4210.8 4219.9 4231.2 4247.1 4259.7 4261.3 4268.0 4271.8 4279.2 4284.3 3510.0 3704.9 3706.9 3708.5 3724.3 5376.5 5427.3 5434.0 5440.7 5468.2 4863.8 4884.4 4930.8 4941.7 4950.0 5585.8 5851.3 5855.3 5862.2 5898.9 4089.6 4096.8 4109.3 4129.3 4131.5 6115.3 6147.8 6152.7 6161.3 6238.6 4055.9 4096.3 4096.6 4199.0 4219.5 4097.2 4109.6 4122.3 4122.9 4155.1 4809.7 4820.1 4839.3 4859.4 4860.7 5736.0 5880.9 5954.6 5957.4 5964.4 1440.6 1447.0 1452.3 1462.3 1462.7 871.1 891.2 915.9 935.9 946.9 4999.2 5037.2 5047.9 5050.8 5060.5 5289.7 5328.4 5346.4 5371.2 5376.2 4985.0 5018.7 5078.0 5330.9 5762.3 3206.6 3225.6 3233.7 3247.7 3253.2 6151.7 6232.3 6263.6 6288.9 6293.4 6107.9 6140.3 6144.6 6146.4 6192.6 6233.7 6306.7 6310.2 6316.5 6318.2 5894.6 6069.2 6080.0 6092.5 6122.5 5920.7 5920.9 6000.6 6015.0 6077.0 5989.4 6263.0 6276.4 6310.3 6350.1 4237.6 4268.7 4270.8 4271.1 4283.7 6190.4 6198.9 6200.5 6206.8 6210.7 5752.5 5995.2 5996.3 6017.8 6072.8 5967.9 5968.9 5969.3 5993.3 6010.9 5690.5 5938.5 5989.7 5996.7 6006.9 5948.9 5981.6 5986.7 5988.7 6002.3 5908.5 5915.5 5919.0 5920.2 5925.0 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - PROCESS | 32294 | [#5] yui.html Cycles:180 Average:21108.27 Median:3794.40 stddev:30335.33 (799.5%) stddev-sans-first:30381.82 19:40:56 INFO - PROCESS | 32294 | Values: 726.5 738.9 745.1 803.2 864.3 15445.2 16140.1 16486.8 16648.7 16659.7 14113.2 14183.1 14190.6 14226.6 14297.9 654.9 786.6 800.0 806.5 819.0 814.4 814.5 816.0 817.2 819.4 869.0 873.0 876.0 878.5 878.5 865.7 866.5 867.0 867.7 870.0 634.2 635.7 636.4 637.7 638.7 13281.0 13354.8 13356.5 13391.5 13410.9 14346.3 14524.7 14659.9 14723.2 14751.6 12617.4 12715.2 12796.6 13002.5 13025.7 3913.2 3955.9 4031.4 4109.2 4113.3 74631.3 75654.0 75888.0 76081.6 79019.8 12201.0 12345.2 12493.9 12522.3 12737.2 23657.5 23679.2 23692.8 23701.6 23707.3 8709.5 8903.4 9172.4 9186.2 9404.6 4758.0 4838.1 4874.3 4960.1 4980.9 3565.8 3652.7 3672.8 3674.9 3675.6 608.2 623.4 631.0 635.1 637.3 622.1 677.3 695.5 739.9 755.2 9937.5 10017.3 10109.4 10350.6 10364.7 678.3 710.2 716.8 720.1 730.5 4742.8 4795.4 4902.2 4904.2 4959.7 96573.5 110372.0 115990.1 122188.4 123186.1 101253.0 103730.0 103797.0 104724.0 105575.5 84344.0 84455.6 89664.6 91555.0 91746.5 9870.2 9969.4 10093.3 10124.1 10255.4 51230.2 51608.7 51872.0 51959.0 52486.7 53407.7 77950.0 78293.6 78331.0 81097.0 12057.0 12406.9 12586.9 12719.7 13034.5 15030.7 15241.2 15370.5 15431.4 16051.1 13313.8 13487.9 13626.5 13680.9 13728.0 13309.2 13354.4 13459.7 14031.2 14137.2 13809.2 13945.9 14207.9 14433.9 14854.8 10268.0 10757.8 10872.6 10930.1 10971.2 10739.8 11031.7 11051.3 11140.5 11211.4 19:40:56 INFO - PROCESS | 32294 | -------- Summary: end -------- 19:40:56 INFO - PROCESS | 32294 | 19:40:56 INFO - TEST-INFO | 32294: exit 0 19:40:56 INFO - TEST-OK | dromaeo_css | took 1111074ms 19:40:56 INFO - TEST-START | kraken 19:40:56 INFO - operating with platform_type : linux_ 19:40:56 INFO - Initialising browser for kraken test... 19:40:56 INFO - TEST-INFO | started process 32541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUZgVA/profile http://localhost:54018/getInfo.html) 19:41:01 INFO - PROCESS | 32541 | __metrics Screen width/height:1600/1200 19:41:01 INFO - PROCESS | 32541 | colorDepth:24 19:41:01 INFO - PROCESS | 32541 | Browser inner width/height: 1024/697 19:41:01 INFO - PROCESS | 32541 | __metrics 19:41:02 ERROR - PROCESS | 32541 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 19:41:03 INFO - TEST-INFO | 32541: exit 0 19:41:03 INFO - Browser initialized. 19:41:03 INFO - Running cycle 1/1 for kraken test... 19:41:03 INFO - TEST-INFO | started process 32659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUZgVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:14 INFO - PROCESS | 32659 | RSS: Main: 167395328 19:41:14 INFO - PROCESS | 32659 | 19:41:17 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54018/tests/kraken/driver.html?testName=audio-beat-detection) 19:41:18 INFO - PROCESS | 32659 | RSS: Main: 172818432 19:41:18 INFO - PROCESS | 32659 | 19:41:20 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54018/tests/kraken/driver.html?testName=audio-dft) 19:41:21 INFO - PROCESS | 32659 | RSS: Main: 172392448 19:41:21 INFO - PROCESS | 32659 | 19:41:24 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54018/tests/kraken/driver.html?testName=audio-fft) 19:41:24 INFO - PROCESS | 32659 | RSS: Main: 167038976 19:41:24 INFO - PROCESS | 32659 | 19:41:27 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54018/tests/kraken/driver.html?testName=audio-oscillator) 19:41:27 INFO - PROCESS | 32659 | RSS: Main: 167931904 19:41:27 INFO - PROCESS | 32659 | 19:41:29 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:41:30 INFO - PROCESS | 32659 | RSS: Main: 168153088 19:41:30 INFO - PROCESS | 32659 | 19:41:33 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54018/tests/kraken/driver.html?testName=imaging-darkroom) 19:41:34 INFO - PROCESS | 32659 | RSS: Main: 168906752 19:41:34 INFO - PROCESS | 32659 | 19:41:37 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54018/tests/kraken/driver.html?testName=imaging-desaturate) 19:41:38 INFO - PROCESS | 32659 | RSS: Main: 166313984 19:41:38 INFO - PROCESS | 32659 | 19:41:41 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54018/tests/kraken/driver.html?testName=json-parse-financial) 19:41:41 INFO - PROCESS | 32659 | RSS: Main: 167190528 19:41:41 INFO - PROCESS | 32659 | 19:41:43 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:41:44 INFO - PROCESS | 32659 | RSS: Main: 168308736 19:41:44 INFO - PROCESS | 32659 | 19:41:45 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:41:46 INFO - PROCESS | 32659 | RSS: Main: 168439808 19:41:46 INFO - PROCESS | 32659 | 19:41:48 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:41:49 INFO - PROCESS | 32659 | RSS: Main: 168529920 19:41:49 INFO - PROCESS | 32659 | 19:41:51 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:41:52 INFO - PROCESS | 32659 | RSS: Main: 168120320 19:41:52 INFO - PROCESS | 32659 | 19:41:55 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:41:55 INFO - PROCESS | 32659 | RSS: Main: 169017344 19:41:55 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | Cycle 1(1): loaded http://localhost:54018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54018/tests/kraken/driver.html?testName=ai-astar) 19:41:57 INFO - PROCESS | 32659 | RSS: Main: 169291776 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | __start_tp_report 19:41:57 INFO - PROCESS | 32659 | _x_x_mozilla_page_load 19:41:57 INFO - PROCESS | 32659 | _x_x_mozilla_page_load_details 19:41:57 INFO - PROCESS | 32659 | |i|pagename|runs| 19:41:57 INFO - PROCESS | 32659 | |0;ai-astar;106;112;106;112;114;113;112;112;112;112 19:41:57 INFO - PROCESS | 32659 | |1;audio-beat-detection;154;120;148;181;119;153;146;116;204;117 19:41:57 INFO - PROCESS | 32659 | |2;audio-dft;164;162;162;167;162;165;166;168;163;163 19:41:57 INFO - PROCESS | 32659 | |3;audio-fft;76;76;85;172;76;76;74;76;177;79 19:41:57 INFO - PROCESS | 32659 | |4;audio-oscillator;85;84;163;85;84;84;143;84;84;150 19:41:57 INFO - PROCESS | 32659 | |5;imaging-gaussian-blur;118;117;118;118;117;116;118;117;117;117 19:41:57 INFO - PROCESS | 32659 | |6;imaging-darkroom;147;147;149;148;148;147;147;148;147;148 19:41:57 INFO - PROCESS | 32659 | |7;imaging-desaturate;96;97;95;96;97;96;96;96;96;95 19:41:57 INFO - PROCESS | 32659 | |8;json-parse-financial;52;55;54;54;55;54;54;65;54;53 19:41:57 INFO - PROCESS | 32659 | |9;json-stringify-tinderbox;61;62;62;61;62;62;61;61;61;62 19:41:57 INFO - PROCESS | 32659 | |10;stanford-crypto-aes;78;82;76;76;81;85;76;77;83;80 19:41:57 INFO - PROCESS | 32659 | |11;stanford-crypto-ccm;122;120;122;122;122;126;135;126;160;122 19:41:57 INFO - PROCESS | 32659 | |12;stanford-crypto-pbkdf2;160;160;162;165;162;160;159;159;162;167 19:41:57 INFO - PROCESS | 32659 | |13;stanford-crypto-sha256-iterative;68;67;65;66;65;64;66;64;64;66 19:41:57 INFO - PROCESS | 32659 | __end_tp_report 19:41:57 INFO - PROCESS | 32659 | __start_cc_report 19:41:57 INFO - PROCESS | 32659 | _x_x_mozilla_cycle_collect,884 19:41:57 INFO - PROCESS | 32659 | __end_cc_report 19:41:57 INFO - PROCESS | 32659 | __startTimestamp1468032117712__endTimestamp 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | ------- Summary: start ------- 19:41:57 INFO - PROCESS | 32659 | Number of tests: 14 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.77 (2.5%) stddev-sans-first:2.24 19:41:57 INFO - PROCESS | 32659 | Values: 106.0 112.0 106.0 112.0 114.0 113.0 112.0 112.0 112.0 112.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:150.50 stddev:29.54 (19.6%) stddev-sans-first:31.18 19:41:57 INFO - PROCESS | 32659 | Values: 154.0 120.0 148.0 181.0 119.0 153.0 146.0 116.0 204.0 117.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:2.20 (1.3%) stddev-sans-first:2.33 19:41:57 INFO - PROCESS | 32659 | Values: 164.0 162.0 162.0 167.0 162.0 165.0 166.0 168.0 163.0 163.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#3] audio-fft Cycles:10 Average:96.70 Median:76.00 stddev:41.13 (54.1%) stddev-sans-first:42.94 19:41:57 INFO - PROCESS | 32659 | Values: 76.0 76.0 85.0 172.0 76.0 76.0 74.0 76.0 177.0 79.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:84.00 stddev:33.06 (39.4%) stddev-sans-first:34.30 19:41:57 INFO - PROCESS | 32659 | Values: 85.0 84.0 163.0 85.0 84.0 84.0 143.0 84.0 84.0 150.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:41:57 INFO - PROCESS | 32659 | Values: 118.0 117.0 118.0 118.0 117.0 116.0 118.0 117.0 117.0 117.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:41:57 INFO - PROCESS | 32659 | Values: 147.0 147.0 149.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:41:57 INFO - PROCESS | 32659 | Values: 96.0 97.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.62 (6.7%) stddev-sans-first:3.67 19:41:57 INFO - PROCESS | 32659 | Values: 52.0 55.0 54.0 54.0 55.0 54.0 54.0 65.0 54.0 53.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 19:41:57 INFO - PROCESS | 32659 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.50 stddev:3.27 (4.1%) stddev-sans-first:3.43 19:41:57 INFO - PROCESS | 32659 | Values: 78.0 82.0 76.0 76.0 81.0 85.0 76.0 77.0 83.0 80.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:124.00 stddev:12.13 (9.8%) stddev-sans-first:12.69 19:41:57 INFO - PROCESS | 32659 | Values: 122.0 120.0 122.0 122.0 122.0 126.0 135.0 126.0 160.0 122.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:2.63 (1.6%) stddev-sans-first:2.73 19:41:57 INFO - PROCESS | 32659 | Values: 160.0 160.0 162.0 165.0 162.0 160.0 159.0 159.0 162.0 167.0 19:41:57 INFO - PROCESS | 32659 | 19:41:57 INFO - PROCESS | 32659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.35 (2.1%) stddev-sans-first:1.09 19:41:57 INFO - PROCESS | 32659 | Values: 68.0 67.0 65.0 66.0 65.0 64.0 66.0 64.0 64.0 66.0 19:41:57 INFO - PROCESS | 32659 | -------- Summary: end -------- 19:41:57 INFO - PROCESS | 32659 | 19:41:58 INFO - TEST-INFO | 32659: exit 0 19:41:58 INFO - TEST-OK | kraken | took 61852ms 19:41:58 INFO - SUITE-END | took 1172s 19:41:58 INFO - Completed test suite (00:19:33) 19:41:58 INFO - javascript benchmark 19:41:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7345.405791153594, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.0357737312743, 3083.352495975845, 3108.953365699514, 3117.3921085388342, 3118.501039833626, 5367.543758780504, 5402.324709411324, 5421.996930567842, 5490.149026900826, 5498.367687715914, 5358.223057656637, 5381.300430943972, 5424.593155513333, 5495.890082198353, 5579.7489112989915, 4862.951370486294, 4887.095887260868, 4966.602671786267, 5021.497850214986, 5062.0, 738.0160419899204, 4860.076585448754, 4907.803687852482, 4957.3059771632, 4957.776900039489, 4950.504949505057, 4986.376702912136, 4987.226979818134, 4991.251312303166, 4995.35060442142, 4976.776045077981, 4981.701097934136, 4997.100521906055, 4997.12550303699, 5039.193729003378, 4857.441394239672, 4911.754412279408, 4931.112399768041, 4934.703917764946, 4939.777710003059, 5443.237946687427, 5446.21029950655, 5487.780488780444, 5493.505584497374, 5514.641548299388, 5651.7739290428335, 5716.028275193227, 5862.062070068769, 5867.941320586782, 5891.145783861316, 5752.252207213036, 5792.623479473821, 5793.0, 5818.912716309259, 5857.033589457735, 5417.10617748075, 5419.051665958442, 5423.593230507728, 5431.755570999315, 5441.29263195786, 5883.205767221456, 5902.527797776168, 5910.083936989773, 5936.406359364029, 5957.582969192115, 5681.517071048925, 5689.743961521742, 5690.971545142248, 5692.260006199168, 5694.06048002075, 5815.563832712563, 5816.360200377955, 5818.243628328375, 5819.5053420459735, 5823.0, 5730.885382292331, 5756.251687280626, 5789.94210057894, 5792.304923409218, 5800.564957628195, 5778.162166485836, 5790.276215473066, 5794.072948328248, 5794.21778059965, 5795.478406943395, 4381.6494680425485, 4433.334999749999, 4447.2439685253585, 4452.821887124479, 4496.437945256843, 3879.0690234343556, 3913.5890731473355, 3943.369060950234, 3947.6644485219076, 3954.5254569451276, 5497.725113744297, 5534.667919924817, 5585.1901474286005, 5630.60585758993, 5636.0982242841765, 5772.7113644317615, 5855.414458554111, 5905.734241959122, 5908.793192238251, 5910.202122713465, 5581.776728930879, 5631.380548139701, 5639.718014099279, 5650.943490565041, 5669.659820410789, 5026.623003274769, 5087.796488140433, 5089.160288552422, 5112.207607820794, 5154.098032844312, 5890.911636325459, 5945.375735547792, 6145.293291271561, 6152.077188421683, 6157.8460538486, 5813.2442782437165, 5831.533477321719, 5845.09401042839, 5874.706264686663, 5913.911291330547, 6060.6969651516365, 6065.120557519047, 6072.483838873745, 6074.42292982166, 6076.997295446202, 5623.8875222496135, 5693.146028095819, 5764.538836893123, 5765.1928729977, 5766.682832444256, 5834.533237341087, 5841.561882858718, 5860.267466566679, 5875.529957603296, 5900.1149827526215, 5657.3776884543495, 5668.433156684298, 5707.771689132388, 5726.255586773693, 5728.398518155534, 5552.361478429871, 5559.0, 5580.665160090408, 5635.633683810539, 5693.715314234355, 5599.412061733622, 5613.0, 5622.803201887914, 5624.718764061862, 5661.179129026351, 5649.971750141223, 5660.773569057192, 5678.630888992202, 5694.601377903507, 5705.515031222392, 5548.750306236309, 5552.444755524415, 5572.609917305912, 5572.749226284908, 5603.327600687943], "value": 5337.088095502811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3763677637942, 583.3291714528294, 596.8328867916983, 608.2670382189463, 635.7933671556746, 41909.79045104774, 42923.35614965778, 45332.999999999956, 45715.08569828601, 45761.084778304416, 45845.54154458454, 46820.063598728004, 46827.76586117064, 46964.0, 47025.529744702544, 8883.51140687262, 9070.0, 9092.8636070459, 9109.544522773867, 9118.133777291147, 8844.07137250589, 8891.288696904232, 8938.1508756668, 8941.821163576724, 8960.820783584324, 8971.685990990316, 9016.68441604544, 9018.639254429814, 9023.909760902405, 9041.457512549268, 8930.776730581754, 8955.059718729537, 8960.417572857743, 8981.101889811032, 8995.100489950984, 8888.288936885034, 8921.884764404449, 8950.239229665487, 8991.100889911022, 8997.055309192507, 43739.34390984138, 44165.337519937224, 44223.77888110571, 44253.336199957026, 44273.33589996152, 2966.362232120083, 3466.4626982817704, 3516.894493165209, 3609.693176080036, 3663.908402289964, 32084.79152084796, 32754.836225818955, 32768.0, 34040.127792971376, 35023.299534009435, 4494.70784399013, 4517.41482395369, 4553.704009239389, 4565.840195593139, 4743.928841067387, 364720.0, 365199.0, 367170.0, 367769.0, 370235.14882425684, 61592.384076159564, 61805.381946179965, 61996.69001655053, 62002.379976200566, 62040.68979655163, 36180.27639447196, 36827.26345473075, 36937.81531092327, 38634.227315453536, 65079.34920650733, 17205.82794172042, 17249.137543122793, 17254.792164548613, 17316.826831731774, 17407.47777566675, 13225.404856781468, 13283.0, 13424.926005919502, 13446.596602101952, 13485.66285842842, 20085.39743807688, 20100.296489622793, 20115.29596464117, 20120.597588048156, 20197.0, 7409.333160015624, 7543.358814500719, 7549.131849837229, 7643.4267429942975, 7721.884171737428, 966.0, 968.9176420004237, 1065.6376831877199, 1074.1267110479437, 1164.9009834164021, 31566.842165789025, 33931.83034084814, 34004.0, 34093.318133637185, 34280.82859585686, 1168.0888906652824, 1184.2953442701578, 1217.6225370135287, 1221.4808706299964, 1283.9550615728592, 17193.65612687739, 17222.913885430742, 17238.0, 17441.49052514354, 17487.30050797979, 611390.0, 613952.0, 618537.0, 619316.0, 623772.0, 60800.0, 61603.6919815407, 61899.0, 61940.38059619346, 62052.68973655193, 1325.5294370498334, 1350.3653282956996, 1371.403439503819, 1380.2753554383828, 1390.1728471559609, 32218.0, 33018.0, 33281.334373312886, 33382.66617333796, 33596.79859839141, 51670.0, 52378.214326784364, 52826.47173528215, 52969.0, 53076.0, 506467.0, 508106.0, 509213.0, 512375.0, 512490.0, 29098.39958802286, 46672.766636166605, 47078.0, 47926.0, 48375.0, 49592.504074960234, 49992.0, 51086.48913510966, 53462.465375345746, 54161.0, 44847.77576112099, 45102.54897450984, 45458.13290174997, 45558.54441455675, 47303.0, 44468.55531444644, 44551.0, 45079.32381014222, 45593.0, 46232.30651540297, 37477.4378384319, 44247.0, 44261.77869110634, 45052.32421513746, 45341.31988020116, 37856.810715946245, 39694.80152599334, 39968.4004739935, 40040.0, 41124.0, 29956.700432996262, 30539.0, 30688.539671905386, 30796.846015769777, 30959.226019349695], "value": 21108.176876821846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.1747803395817, 396.988090357289, 398.1241269207743, 398.9301872172371, 419.2139737991266, 16580.0, 19101.23595056198, 19538.90230548849, 20675.069621867035, 20738.688919666216, 18851.52871178221, 19305.227790888348, 19368.709469357935, 19453.513662158453, 19468.610627787435, 5670.0927851543765, 5772.711364431782, 5776.855578610526, 5777.971110144444, 5801.535877129841, 5575.609707320489, 5670.319561652607, 5673.971630141844, 5763.193152958589, 5777.768889244425, 5487.314085739283, 5673.063944449161, 5687.488126068653, 5689.6017278790505, 5693.800716974907, 5573.832785016456, 5617.606767526275, 5630.352509461403, 5648.74580643872, 5674.177244299594, 5006.69959802413, 5114.079465696173, 5133.51231632998, 5146.3824341078935, 5159.922601160985, 22408.887955560116, 22876.542469150525, 23319.41701457477, 23529.41176470585, 23571.528569428687, 2340.578695834749, 2469.09877894569, 2587.3531617095728, 2594.5848664213822, 2628.4743051389605, 14124.92937535316, 14908.62728431798, 15023.09861408319, 15035.849641503664, 15209.315580798891, 1859.172668162668, 1920.836728878047, 1989.3634037108131, 2024.4331587155473, 2044.0, 70979.64510177416, 73923.0, 74025.0, 80038.59980700117, 83057.58471207666, 10766.354018758899, 11095.167862410352, 11123.443827808576, 11258.718532036764, 11287.717807054889, 12245.816312755316, 13026.41381137851, 13090.607281781562, 15284.38862445512, 15483.458078967182, 7749.651265693057, 7794.0, 8125.1062383137805, 8188.590570471452, 8233.670653173926, 8144.0, 8184.54984975832, 8185.467944583702, 8351.457155284887, 8358.540280284522, 4053.7162398631813, 4066.8373265069067, 4118.814653340607, 4213.747175169499, 4234.724742891703, 1843.4653950354516, 1886.8962207078741, 1957.667196576557, 1998.7801341852385, 2060.5054786851047, 959.2182371367313, 976.4434272464769, 987.7652933832709, 1041.8124737547162, 1064.7178497698117, 19084.809151908303, 19469.415917522496, 19698.50753731168, 19880.50298742543, 19906.104225309897, 1004.3672486333563, 1022.3303736052898, 1026.650938680852, 1036.3315661398356, 1056.3081181825917, 10661.84007239892, 10939.0, 11064.170187235828, 11086.61196858106, 11087.113030957504, 484232.0, 489153.0, 489809.0, 490671.0, 490945.0, 89649.55175224082, 91523.54238228766, 93410.0, 97707.0, 98921.0, 1008.9192864570816, 1053.5259133390005, 1055.3931489393628, 1058.0583280880023, 1067.4502631144967, 17555.473335799947, 17689.38087166943, 18243.361482348053, 18306.633867322846, 18329.3584724534, 43078.846057697614, 43313.783431082644, 43853.12293754171, 44558.77720611376, 44644.55355446534, 63338.0, 63970.36029639644, 64897.35102648913, 64978.35021649723, 65628.0, 8652.913470865211, 8787.121287871161, 8873.73704839739, 8951.865722014305, 9045.140711632384, 13073.673158171121, 13763.655908602364, 14085.295735212994, 14384.856151438771, 14462.421503139756, 11862.40687965581, 12041.45813438415, 12499.750004999667, 12760.361981901053, 12795.0, 12034.097442692007, 12173.634790955932, 12262.0, 12712.872871271169, 12798.16811907223, 6188.81433556994, 11751.236169648946, 12538.498460061495, 12603.68490787701, 12647.177933434297, 7763.107242667165, 7823.647935843014, 8087.757367278991, 8764.91235087641, 8944.150305720947, 8596.871046934177, 11301.491432885376, 12069.637910862688, 12438.502459901503, 12438.626841194779], "value": 9363.232147830204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.8551144885512, 1479.4082367053181, 1611.1299898055051, 1770.9645807083866, 1777.2890843662526, 7424.814379640512, 8272.793180170498, 8273.214044665747, 8751.91248087519, 8758.12418758124, 8333.374996875229, 8557.22984931356, 8657.177568131034, 8665.95667021664, 8668.436551624156, 2273.2839155665997, 2311.653252012195, 2311.699479067719, 2316.81465482761, 2317.6986991691056, 2253.853499522534, 2256.6050941085327, 2294.242899843048, 2294.3919861236786, 2315.8263130265213, 2273.2952784636814, 2290.1297506947335, 2293.2546922250335, 2319.22306027481, 2321.210788331967, 2245.247841972941, 2258.006477150057, 2267.682524446579, 2273.0, 2281.315605318398, 1904.4667493101954, 1940.9708854367195, 1948.2888745607752, 1951.863369564131, 1953.1796645408963, 8559.400841941067, 8575.785605359915, 8583.356248281403, 8623.223909848144, 8630.395872288942, 4943.134951383529, 5064.442911279756, 5076.340075790161, 5076.619253555961, 5088.872778180538, 3047.4666933286585, 3157.7947433416984, 3189.856456459465, 3212.9236705703615, 3216.8713251469912, 1042.7601651620093, 1069.8288273876142, 1090.6837017264984, 1105.850710154127, 1105.9612913548067, 11187.160962927814, 11482.655520334403, 11494.770104597945, 11668.299902005907, 11704.88295117055, 4199.4120823084795, 4355.5208927018, 4387.978060109743, 4434.046679963823, 4447.933281000787, 9145.222656074175, 9173.862392064124, 9196.0, 9209.585568649427, 9215.861762073575, 5107.284980102789, 5116.309298244763, 5121.334226550524, 5123.231515272664, 5125.743712814345, 4257.787110644517, 4612.7462989535225, 4697.13103075932, 4724.031573527419, 4775.235962246094, 3563.2873425314524, 3591.712662986955, 3657.23198128396, 3703.4259689748133, 3705.166337574078, 1109.5506319940437, 1119.0655802405083, 1129.2829053551054, 1131.9547218111347, 1137.3176094343328, 793.4882001109253, 947.725159703692, 952.7760976170595, 970.3256236915418, 1007.5818535307765, 5908.291005079418, 5929.347771745104, 5933.110033494924, 6085.939140608537, 6238.906416403757, 423.8347044652588, 434.2227412930882, 451.2126339537528, 455.760725619046, 456.0878243512974, 4124.587541245852, 4166.291730405838, 4184.497860256789, 4189.329707246826, 4202.243596152722, 9960.103590676874, 10246.948765256126, 10309.84535231972, 10316.48417579118, 10331.276810623183, 10154.644587439405, 10207.285490015627, 10250.436226007641, 10256.538455769509, 10265.897341026643, 7610.200928902385, 7911.12977572455, 7939.920600794034, 7943.165967573322, 7943.801404964922, 6095.786647467317, 6225.750969961151, 6336.998696722823, 6359.491240700825, 6428.774992875227, 9629.229661627192, 9852.901470985486, 9858.063483969012, 9931.453770042717, 9946.104850563195, 9475.620975161191, 9814.214862810815, 10025.398476091457, 10100.696979090639, 10134.0, 6775.966120169368, 7565.092188937363, 7640.73257435987, 7740.729074482591, 7892.723754668559, 8231.34149268069, 8422.031466381199, 8471.872921906053, 8481.0, 8505.277051450696, 7389.0, 7582.203868593939, 7604.505707129019, 7684.692612295669, 7706.845863082819, 7209.747658832125, 7472.476926615085, 7575.621218938921, 7578.12851522082, 7641.350485208597, 6931.306869313028, 6969.6515174242095, 7038.718451261892, 7043.718251269892, 7057.50597458173, 5187.1181899078, 5326.440723723953, 5424.186372044225, 5450.155225939986, 5466.535344495763, 5169.638125331341, 5191.584673226057, 5296.629235953446, 5352.090144675337, 5446.918296225481], "value": 4407.059736983541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.36532705431625, 299.82160614434406, 299.94301082794266, 305.9648140463847, 309.66710785905155, 5379.9731001344935, 5490.890182196354, 5569.359523654781, 5665.348484924235, 5689.544836413087, 5530.5852061095375, 5544.390117087117, 5548.55611551076, 5549.750261238244, 5571.164325351199, 4328.826846926119, 4355.673324500659, 4355.716878402894, 4376.737395756265, 4388.692791504596, 4071.8982025449454, 4255.319148936168, 4257.531671516131, 4364.323529852878, 4382.386465894777, 4210.768407737573, 4219.8606376278385, 4231.196072746168, 4247.108107297471, 4259.6805239607, 4261.339492378686, 4267.957320426787, 4271.829126834954, 4279.239890270789, 4284.2930916398755, 3509.982450087759, 3704.8888533343775, 3706.8517259309597, 3708.5178926739623, 3724.3296206682785, 5376.51611354976, 5427.348718153847, 5433.994710978482, 5440.6735595863975, 5468.179773034037, 4863.781129849165, 4884.436980166348, 4930.827421040282, 4941.654084214107, 4949.975250123763, 5585.804496842632, 5851.3270973838125, 5855.272694555117, 5862.20860183874, 5898.941010589882, 4089.5501494835544, 4096.815643296029, 4109.260333140033, 4129.256733787917, 4131.462909821734, 6115.296740874812, 6147.78482753106, 6152.723127459275, 6161.260648722137, 6238.625682459022, 4055.8986025349013, 4096.344584866407, 4096.569860164699, 4198.971252043269, 4219.51475580306, 4097.2010457961005, 4109.609587089221, 4122.2786012447705, 4122.856114820277, 4155.148194620156, 4809.663323567317, 4820.084184005028, 4839.2983017462275, 4859.3759369939835, 4860.684055536379, 5735.971320143456, 5880.882382352329, 5954.612950158225, 5957.4042595740075, 5964.373740757244, 1440.5750303660445, 1447.0, 1452.2593477326639, 1462.2542503323168, 1462.7293950619169, 871.1375738019442, 891.2379915172435, 915.8992510823804, 935.9157675809209, 946.947917864524, 4999.225120106389, 5037.244413338029, 5047.873803154877, 5050.84847454577, 5060.51925067118, 5289.677580604849, 5328.387235467893, 5346.406992608581, 5371.167469042305, 5376.220448035013, 4984.950150498521, 5018.749062546858, 5077.974610126926, 5330.92003619946, 5762.30852297727, 3206.631237407728, 3225.6290526589273, 3233.7251333636905, 3247.675232476781, 3253.170441537393, 6151.692415379213, 6232.283287421914, 6263.592866463665, 6288.937110628835, 6293.370662933761, 6107.938920610737, 6140.280721398016, 6144.600600960924, 6146.385361463817, 6192.628442293477, 6233.657148856766, 6306.65313407767, 6310.242770867433, 6316.463100636497, 6318.241810982619, 5894.557908156819, 6069.241344831896, 6079.969600151971, 6092.543059270483, 6122.5408094392205, 5920.703964801656, 5920.911186332122, 6000.5799594028, 6015.0, 6077.0, 5989.3711160329285, 6263.0, 6276.399518122849, 6310.286576771849, 6350.1109844622715, 4237.5762423758615, 4268.743875367488, 4270.765107919095, 4271.081717430768, 4283.7001409901, 6190.350013248544, 6198.876022479435, 6200.503959683124, 6206.813795586139, 6210.658413787285, 5752.453516916054, 5995.220621319375, 5996.310424301087, 6017.849553761191, 6072.787452439144, 5967.880642387215, 5968.850778730566, 5969.283685957713, 5993.310769261417, 6010.909836352371, 5690.544756419394, 5938.524918006463, 5989.670568118795, 5996.691273859683, 6006.87986240264, 5948.910766338595, 5981.641101533922, 5986.653003074273, 5988.6706231157705, 6002.3097343804275, 5908.468237858441, 5915.526757859275, 5918.993771058844, 5920.200772895604, 5924.9703751480965], "value": 4397.130720857976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4624178108195, 738.8670039392908, 745.0575022596416, 803.1647087029489, 864.2696921101668, 15445.227738613066, 16140.112293823835, 16486.83513164868, 16648.66702665949, 16659.66680666386, 14113.223772692498, 14183.149011059344, 14190.645233869158, 14226.573202803907, 14297.857021429783, 654.8624788794335, 786.5634572812087, 799.9520028798262, 806.4556424413527, 819.0417211862106, 814.4461765999118, 814.5357146426539, 816.0411516468156, 817.2236375443323, 819.4059307002406, 868.956552172392, 872.9825403491926, 876.0188588780575, 878.5080355001188, 878.5431575580694, 865.6537385045968, 866.4757821517985, 866.9609867555976, 867.7353407210799, 870.0472982084607, 634.175571756719, 635.7139287320724, 636.4176778247944, 637.6684124255361, 638.7157714816908, 13281.0, 13354.799678004838, 13356.465741370333, 13391.531296404579, 13410.93294533531, 14346.28268586577, 14524.70950580993, 14659.92670036643, 14723.190224537646, 14751.631209219748, 12617.36155315083, 12715.237085774883, 12796.61610151697, 13002.479900803957, 13025.739485210242, 3913.236918800835, 3955.8615448459454, 4031.3549832026733, 4109.198706252282, 4113.300738874369, 74631.25368746297, 75654.0, 75888.0, 76081.61959190224, 79019.81470278007, 12201.0, 12345.197562158432, 12493.93753031229, 12522.311272880079, 12737.172083814523, 23657.52684946326, 23679.1712290069, 23692.763072369056, 23701.644475332883, 23707.28878133659, 8709.477431354138, 8903.421277617064, 9172.357934944623, 9186.173244407903, 9404.576794044284, 4757.95242047582, 4838.080764654775, 4874.293227482066, 4960.0575890581395, 4980.850574482772, 3565.8217089145437, 3652.652997965189, 3672.8163591820303, 3674.9448758268645, 3675.5589329280124, 608.2002167150183, 623.4445059576295, 630.9779157729457, 635.0664523150961, 637.3339859846471, 622.1414448061646, 677.2672267401014, 695.4957655699678, 739.9408047356198, 755.2221212151493, 9937.453440060866, 10017.348872323275, 10109.39343639384, 10350.637727679496, 10364.689059328231, 678.328454829715, 710.1939298895791, 716.7527203114917, 720.0854914258862, 730.5065904398996, 4742.786574604151, 4795.352627395327, 4902.215645496774, 4904.215325547895, 4959.652824302337, 96573.5171324139, 110372.0, 115990.10024749448, 122188.38905805413, 123186.14510839111, 101253.0, 103730.0, 103797.0, 104724.0, 105575.47212264044, 84344.0, 84455.57772210977, 89664.5516772425, 91555.0, 91746.54126729457, 9870.210383169473, 9969.40183588987, 10093.343932644648, 10124.139448146696, 10255.435951022766, 51230.23154652608, 51608.74195628998, 51872.0, 51959.0, 52486.737566311924, 53407.73296133494, 77950.0, 78293.60853195697, 78331.0, 81097.0, 12057.0, 12406.875931240933, 12586.886349684111, 12719.682007949505, 13034.47862085506, 15030.699386012437, 15241.161736104621, 15370.462033828762, 15431.382744690087, 16051.117188554741, 13313.800292995806, 13487.865121348661, 13626.523071692443, 13680.863191368357, 13728.0, 13309.201447913156, 13354.399052042876, 13459.663508412368, 14031.228282444563, 14137.151770893779, 13809.171449713049, 13945.930270348988, 14207.857921421068, 14433.92783036078, 14854.77717834255, 10268.024537668909, 10757.784844302914, 10872.61945831892, 10930.125589952944, 10971.156811827834, 10739.785204296026, 11031.724206894893, 11051.336919784517, 11140.498677559368, 11211.439428028729], "value": 7683.306339757708, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 106.0, 112.0, 114.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 148.0, 181.0, 119.0, 153.0, 146.0, 116.0, 204.0, 117.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 167.0, 162.0, 165.0, 166.0, 168.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 85.0, 172.0, 76.0, 76.0, 74.0, 76.0, 177.0, 79.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 163.0, 85.0, 84.0, 84.0, 143.0, 84.0, 84.0, 150.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 65.0, 54.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 76.0, 76.0, 81.0, 85.0, 76.0, 77.0, 83.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 122.0, 122.0, 122.0, 126.0, 135.0, 126.0, 160.0, 122.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 165.0, 162.0, 160.0, 159.0, 159.0, 162.0, 167.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 66.0, 65.0, 64.0, 66.0, 64.0, 64.0, 66.0], "value": 65.5, "unit": "score"}]}]} 19:41:58 INFO - Return code: 0 19:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:41:59 ERROR - # TBPL SUCCESS # 19:41:59 INFO - Running post-action listener: _resource_record_post_action 19:41:59 INFO - ##### 19:41:59 INFO - ##### Finished run-tests step (success) 19:41:59 INFO - ##### 19:41:59 INFO - Running post-run listener: _resource_record_post_run 19:41:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 552665088; Read time: 136; Write time: 386584 19:41:59 INFO - TinderboxPrint: CPU usage
13.3% 19:41:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 136 19:41:59 INFO - TinderboxPrint: I/O write bytes / time
552,665,088 / 386,584 19:41:59 INFO - TinderboxPrint: CPU idle
8,235.9 (86.7%) 19:41:59 INFO - TinderboxPrint: CPU user
1,212.9 (12.8%) 19:41:59 INFO - TinderboxPrint: Swap in / out
0 / 0 19:41:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 256782336; Read time: 0; Write time: 220056 19:41:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295882752; Read time: 116; Write time: 166528 19:41:59 INFO - Running post-run listener: _upload_blobber_files 19:41:59 INFO - Blob upload gear active. 19:41:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:41:59 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 19:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:42:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:03 INFO - (blobuploader) - INFO - Done attempting. 19:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:04 INFO - (blobuploader) - INFO - Done attempting. 19:42:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:42:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:05 INFO - (blobuploader) - INFO - Done attempting. 19:42:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:42:05 INFO - Return code: 0 19:42:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:42:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:42:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01c6aec748b365dab0049818528a3a57206f7ccaf1caa3947dffe1c77ec160bb2523bf7e2f0b95f5ee2e1831dc6ed9766e5cc334af7ef529e07d59ec92eb4af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51e715ed0a925e5941681e0b955ca07e855d63c0a9437a82fd6454516f927cba6fb881c7d485057529ccc6d430b54b1e2cf4944b62f13865aa07ae46aba6068f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f152cd023149a8a7a98dca7a79daa9d0f1cb4c8a3221ccf1f36d5540d4247539e0e7078bcac53310789c3af4b47d6f07a3fc31cc8108a37ddb2bde3d8cb5388"} 19:42:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:42:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:42:05 INFO - Contents: 19:42:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01c6aec748b365dab0049818528a3a57206f7ccaf1caa3947dffe1c77ec160bb2523bf7e2f0b95f5ee2e1831dc6ed9766e5cc334af7ef529e07d59ec92eb4af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51e715ed0a925e5941681e0b955ca07e855d63c0a9437a82fd6454516f927cba6fb881c7d485057529ccc6d430b54b1e2cf4944b62f13865aa07ae46aba6068f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f152cd023149a8a7a98dca7a79daa9d0f1cb4c8a3221ccf1f36d5540d4247539e0e7078bcac53310789c3af4b47d6f07a3fc31cc8108a37ddb2bde3d8cb5388"} 19:42:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:42:05 INFO - Copying logs to upload dir... 19:42:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:42:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.353377 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-08 19:42:05.197338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:05.201781) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01c6aec748b365dab0049818528a3a57206f7ccaf1caa3947dffe1c77ec160bb2523bf7e2f0b95f5ee2e1831dc6ed9766e5cc334af7ef529e07d59ec92eb4af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51e715ed0a925e5941681e0b955ca07e855d63c0a9437a82fd6454516f927cba6fb881c7d485057529ccc6d430b54b1e2cf4944b62f13865aa07ae46aba6068f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f152cd023149a8a7a98dca7a79daa9d0f1cb4c8a3221ccf1f36d5540d4247539e0e7078bcac53310789c3af4b47d6f07a3fc31cc8108a37ddb2bde3d8cb5388"} build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/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/Mozilla-Inbound/sha512/f01c6aec748b365dab0049818528a3a57206f7ccaf1caa3947dffe1c77ec160bb2523bf7e2f0b95f5ee2e1831dc6ed9766e5cc334af7ef529e07d59ec92eb4af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51e715ed0a925e5941681e0b955ca07e855d63c0a9437a82fd6454516f927cba6fb881c7d485057529ccc6d430b54b1e2cf4944b62f13865aa07ae46aba6068f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f152cd023149a8a7a98dca7a79daa9d0f1cb4c8a3221ccf1f36d5540d4247539e0e7078bcac53310789c3af4b47d6f07a3fc31cc8108a37ddb2bde3d8cb5388"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:05.234958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:05.235354) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468030325.590318-927571847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:05.599389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:42:05.599794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:42:05.600210) ========= ========= Total master_lag: 0.61 =========