builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1468744860.1 results: success (0) buildid: 20160717001753 builduid: a92869d540e44da4bb7360d699ff9bc7 revision: ef5f932101e5b833b2429407cb0873471b4d764e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.101611) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.102056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.102342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.116905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.117227) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 01:41:01-- 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% 82.3M=0s 2016-07-17 01:41:01 (82.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.321981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.454881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.455403) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013636 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.507624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:00.508177) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ef5f932101e5b833b2429407cb0873471b4d764e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ef5f932101e5b833b2429407cb0873471b4d764e --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=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 01:41:01,545 truncating revision to first 12 chars 2016-07-17 01:41:01,546 Setting DEBUG logging. 2016-07-17 01:41:01,546 attempt 1/10 2016-07-17 01:41:01,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ef5f932101e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 01:41:01,838 unpacking tar archive at: mozilla-central-ef5f932101e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:01.154710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:01.155248) ========= script_repo_revision: ef5f932101e5b833b2429407cb0873471b4d764e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:01.155866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:01.156333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 01:41:01.167893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-17 01:41:01.168366) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:41:02 INFO - MultiFileLogger online at 20160717 01:41:02 in /builds/slave/test 01:41:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:41:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:41:02 INFO - {'append_to_log': False, 01:41:02 INFO - 'base_work_dir': '/builds/slave/test', 01:41:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:41:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:41:02 INFO - 'branch': 'Firefox-Non-PGO', 01:41:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:41:02 INFO - 'config_files': ('talos/linux_config.py',), 01:41:02 INFO - 'default_actions': ('clobber', 01:41:02 INFO - 'read-buildbot-config', 01:41:02 INFO - 'download-and-extract', 01:41:02 INFO - 'populate-webroot', 01:41:02 INFO - 'create-virtualenv', 01:41:02 INFO - 'install', 01:41:02 INFO - 'run-tests'), 01:41:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:41:02 INFO - 'download_minidump_stackwalk': True, 01:41:02 INFO - 'download_symbols': 'ondemand', 01:41:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:41:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:41:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:41:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:41:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:41:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:41:02 INFO - 'installer_path': 'installer.exe', 01:41:02 INFO - 'log_level': 'info', 01:41:02 INFO - 'log_name': 'talos', 01:41:02 INFO - 'log_to_console': True, 01:41:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:41:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:41:02 INFO - 'opt_config_files': (), 01:41:02 INFO - 'pip_index': False, 01:41:02 INFO - 'sps_profile': False, 01:41:02 INFO - 'sps_profile_interval': 0, 01:41:02 INFO - 'suite': 'dromaeojs-e10s', 01:41:02 INFO - 'system_bits': '32', 01:41:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:41:02 INFO - 'title': 'talos-linux64-ix-064', 01:41:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:41:02 INFO - 'use_talos_json': True, 01:41:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:41:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:41:02 INFO - 'work_dir': 'build'} 01:41:02 INFO - ##### 01:41:02 INFO - ##### Running clobber step. 01:41:02 INFO - ##### 01:41:02 INFO - Running pre-action listener: _resource_record_pre_action 01:41:02 INFO - Running main action method: clobber 01:41:02 INFO - rmtree: /builds/slave/test/build 01:41:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:41:02 INFO - Running post-action listener: _resource_record_post_action 01:41:02 INFO - ##### 01:41:02 INFO - ##### Finished clobber step (success) 01:41:02 INFO - ##### 01:41:02 INFO - ##### 01:41:02 INFO - ##### Running read-buildbot-config step. 01:41:02 INFO - ##### 01:41:02 INFO - Running pre-action listener: _resource_record_pre_action 01:41:02 INFO - Running main action method: read_buildbot_config 01:41:02 INFO - Using buildbot properties: 01:41:02 INFO - { 01:41:02 INFO - "project": "", 01:41:02 INFO - "product": "firefox", 01:41:02 INFO - "script_repo_revision": "production", 01:41:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:41:02 INFO - "repository": "", 01:41:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:41:02 INFO - "buildid": "20160717001753", 01:41:02 INFO - "pgo_build": "False", 01:41:02 INFO - "basedir": "/builds/slave/test", 01:41:02 INFO - "buildnumber": 382, 01:41:02 INFO - "slavename": "talos-linux64-ix-064", 01:41:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:41:02 INFO - "platform": "ubuntu64_hw", 01:41:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:41:02 INFO - "branch": "mozilla-central", 01:41:02 INFO - "repo_path": "mozilla-central", 01:41:02 INFO - "revision": "ef5f932101e5b833b2429407cb0873471b4d764e", 01:41:02 INFO - "stage_platform": "linux64", 01:41:02 INFO - "builduid": "a92869d540e44da4bb7360d699ff9bc7", 01:41:02 INFO - "slavebuilddir": "test" 01:41:02 INFO - } 01:41:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:41:02 INFO - Running post-action listener: _resource_record_post_action 01:41:02 INFO - ##### 01:41:02 INFO - ##### Finished read-buildbot-config step (success) 01:41:02 INFO - ##### 01:41:02 INFO - ##### 01:41:02 INFO - ##### Running download-and-extract step. 01:41:02 INFO - ##### 01:41:02 INFO - Running pre-action listener: _resource_record_pre_action 01:41:02 INFO - Running main action method: download_and_extract 01:41:02 INFO - mkdir: /builds/slave/test/build/tests 01:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:02 INFO - https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:41:04 INFO - Downloaded 1361 bytes. 01:41:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:41:04 INFO - Using the following test package requirements: 01:41:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:41:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:41:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:41:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'jsshell-linux-x86_64.zip'], 01:41:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:41:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:41:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:41:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:41:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:41:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:41:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:41:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:04 INFO - https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:41:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:41:05 INFO - Downloaded 22757494 bytes. 01:41:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:41:07 INFO - Return code: 0 01:41:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:07 INFO - https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:41:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:41:28 INFO - Downloaded 22757494 bytes. 01:41:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:41:29 INFO - Return code: 0 01:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:29 INFO - https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:41:30 INFO - Downloaded 14403317 bytes. 01:41:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:41:30 INFO - Return code: 0 01:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:30 INFO - https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:41:32 INFO - Downloaded 57076462 bytes. 01:41:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:41:32 INFO - mkdir: /builds/slave/test/properties 01:41:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:41:32 INFO - Writing to file /builds/slave/test/properties/build_url 01:41:32 INFO - Contents: 01:41:32 INFO - build_url:https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:41:33 INFO - Running post-action listener: _resource_record_post_action 01:41:33 INFO - Running post-action listener: set_extra_try_arguments 01:41:33 INFO - ##### 01:41:33 INFO - ##### Finished download-and-extract step (success) 01:41:33 INFO - ##### 01:41:33 INFO - ##### 01:41:33 INFO - ##### Running populate-webroot step. 01:41:33 INFO - ##### 01:41:33 INFO - Running pre-action listener: _resource_record_pre_action 01:41:33 INFO - Running main action method: populate_webroot 01:41:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:41:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:41:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:41:33 INFO - '--tppagecycles', 01:41:33 INFO - '7'], 01:41:33 INFO - 'tests': ['tsvgm']}}, 01:41:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:41:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:41:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:41:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:41:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:41:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['damp', 'tps']}, 01:41:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'tests': ['damp', 'tps']}, 01:41:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['dromaeo_dom']}, 01:41:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:41:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['basic_compositor_video']}, 01:41:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:41:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'other-e10s': {'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['a11yr', 01:41:33 INFO - 'ts_paint', 01:41:33 INFO - 'tpaint', 01:41:33 INFO - 'sessionrestore', 01:41:33 INFO - 'sessionrestore_no_auto_restore', 01:41:33 INFO - 'tabpaint']}, 01:41:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['tsvgx', 01:41:33 INFO - 'tsvgr_opacity', 01:41:33 INFO - 'tart', 01:41:33 INFO - 'tscrollx', 01:41:33 INFO - 'cart']}, 01:41:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:41:33 INFO - 'tsvgr_opacity', 01:41:33 INFO - 'tart', 01:41:33 INFO - 'tscrollx', 01:41:33 INFO - 'cart']}, 01:41:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'talos_options': ['--disable-e10s'], 01:41:33 INFO - 'tests': ['tp5o']}, 01:41:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'tests': ['tp5o']}, 01:41:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'talos_options': ['--disable-e10s', 01:41:33 INFO - '--xperf_path', 01:41:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:33 INFO - 'tests': ['tp5n']}, 01:41:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:41:33 INFO - 'talos_options': ['--xperf_path', 01:41:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:41:33 INFO - 'tests': ['tp5n']}}, 01:41:33 INFO - 'talos.zip': {'path': '', 01:41:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:41:33 INFO - Running post-action listener: _resource_record_post_action 01:41:33 INFO - ##### 01:41:33 INFO - ##### Finished populate-webroot step (success) 01:41:33 INFO - ##### 01:41:33 INFO - ##### 01:41:33 INFO - ##### Running create-virtualenv step. 01:41:33 INFO - ##### 01:41:33 INFO - Running pre-action listener: _resource_record_pre_action 01:41:33 INFO - Running main action method: create_virtualenv 01:41:33 INFO - Creating virtualenv /builds/slave/test/build/venv 01:41:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:41:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:41:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:41:33 INFO - Using real prefix '/usr' 01:41:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:41:33 INFO - Installing distribute.............................................................................................................................................................................................done. 01:41:35 INFO - Installing pip.................done. 01:41:35 INFO - Return code: 0 01:41:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:41:35 INFO - Using env: {'DISPLAY': ':0', 01:41:35 INFO - 'HOME': '/home/cltbld', 01:41:35 INFO - 'LANG': 'en_US.UTF-8', 01:41:35 INFO - 'LANGUAGE': 'en_US:en', 01:41:35 INFO - 'LOGNAME': 'cltbld', 01:41:35 INFO - 'MAIL': '/var/mail/cltbld', 01:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:35 INFO - 'MOZ_NO_REMOTE': '1', 01:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:35 INFO - 'NO_EM_RESTART': '1', 01:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:35 INFO - 'PWD': '/builds/slave/test', 01:41:35 INFO - 'SHELL': '/bin/bash', 01:41:35 INFO - 'SHLVL': '1', 01:41:35 INFO - 'TERM': 'linux', 01:41:35 INFO - 'TMOUT': '86400', 01:41:35 INFO - 'USER': 'cltbld', 01:41:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:35 INFO - '_': '/tools/buildbot/bin/python'} 01:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:41:35 INFO - Cleaning up... 01:41:35 INFO - Return code: 0 01:41:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:35 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:41:35 INFO - Using env: {'DISPLAY': ':0', 01:41:35 INFO - 'HOME': '/home/cltbld', 01:41:35 INFO - 'LANG': 'en_US.UTF-8', 01:41:35 INFO - 'LANGUAGE': 'en_US:en', 01:41:35 INFO - 'LOGNAME': 'cltbld', 01:41:35 INFO - 'MAIL': '/var/mail/cltbld', 01:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:35 INFO - 'MOZ_NO_REMOTE': '1', 01:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:35 INFO - 'NO_EM_RESTART': '1', 01:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:35 INFO - 'PWD': '/builds/slave/test', 01:41:35 INFO - 'SHELL': '/bin/bash', 01:41:35 INFO - 'SHLVL': '1', 01:41:35 INFO - 'TERM': 'linux', 01:41:35 INFO - 'TMOUT': '86400', 01:41:35 INFO - 'USER': 'cltbld', 01:41:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:35 INFO - '_': '/tools/buildbot/bin/python'} 01:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:36 INFO - Downloading/unpacking psutil>=3.1.1 01:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:41:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:38 INFO - Installing collected packages: psutil 01:41:38 INFO - Running setup.py install for psutil 01:41:38 INFO - building 'psutil._psutil_linux' extension 01:41:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:41:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:41:38 INFO - building 'psutil._psutil_posix' extension 01:41:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:41:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:41:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:41:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:41:38 INFO - Successfully installed psutil 01:41:38 INFO - Cleaning up... 01:41:38 INFO - Return code: 0 01:41:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:41:38 INFO - Using env: {'DISPLAY': ':0', 01:41:38 INFO - 'HOME': '/home/cltbld', 01:41:38 INFO - 'LANG': 'en_US.UTF-8', 01:41:38 INFO - 'LANGUAGE': 'en_US:en', 01:41:38 INFO - 'LOGNAME': 'cltbld', 01:41:38 INFO - 'MAIL': '/var/mail/cltbld', 01:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:38 INFO - 'MOZ_NO_REMOTE': '1', 01:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:38 INFO - 'NO_EM_RESTART': '1', 01:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:38 INFO - 'PWD': '/builds/slave/test', 01:41:38 INFO - 'SHELL': '/bin/bash', 01:41:38 INFO - 'SHLVL': '1', 01:41:38 INFO - 'TERM': 'linux', 01:41:38 INFO - 'TMOUT': '86400', 01:41:38 INFO - 'USER': 'cltbld', 01:41:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:38 INFO - '_': '/tools/buildbot/bin/python'} 01:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:41:40 INFO - Installing collected packages: mozsystemmonitor 01:41:40 INFO - Running setup.py install for mozsystemmonitor 01:41:40 INFO - Successfully installed mozsystemmonitor 01:41:40 INFO - Cleaning up... 01:41:40 INFO - Return code: 0 01:41:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:40 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:41:40 INFO - Using env: {'DISPLAY': ':0', 01:41:40 INFO - 'HOME': '/home/cltbld', 01:41:40 INFO - 'LANG': 'en_US.UTF-8', 01:41:40 INFO - 'LANGUAGE': 'en_US:en', 01:41:40 INFO - 'LOGNAME': 'cltbld', 01:41:40 INFO - 'MAIL': '/var/mail/cltbld', 01:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:40 INFO - 'MOZ_NO_REMOTE': '1', 01:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:40 INFO - 'NO_EM_RESTART': '1', 01:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:40 INFO - 'PWD': '/builds/slave/test', 01:41:40 INFO - 'SHELL': '/bin/bash', 01:41:40 INFO - 'SHLVL': '1', 01:41:40 INFO - 'TERM': 'linux', 01:41:40 INFO - 'TMOUT': '86400', 01:41:40 INFO - 'USER': 'cltbld', 01:41:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:40 INFO - '_': '/tools/buildbot/bin/python'} 01:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:41 INFO - Downloading/unpacking jsonschema==2.5.1 01:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:43 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:43 INFO - warning: no files found matching '*.txt' 01:41:43 INFO - no previously-included directories found matching 'build' 01:41:43 INFO - no previously-included directories found matching 'dist' 01:41:43 INFO - no previously-included directories found matching '.git*' 01:41:43 INFO - Installing collected packages: jsonschema, functools32 01:41:43 INFO - Running setup.py install for functools32 01:41:43 INFO - warning: no files found matching '*.txt' 01:41:43 INFO - no previously-included directories found matching 'build' 01:41:43 INFO - no previously-included directories found matching 'dist' 01:41:43 INFO - no previously-included directories found matching '.git*' 01:41:43 INFO - Successfully installed jsonschema functools32 01:41:43 INFO - Cleaning up... 01:41:43 INFO - Return code: 0 01:41:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:41: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')]} 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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')]} 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:43 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:41:43 INFO - Using env: {'DISPLAY': ':0', 01:41:43 INFO - 'HOME': '/home/cltbld', 01:41:43 INFO - 'LANG': 'en_US.UTF-8', 01:41:43 INFO - 'LANGUAGE': 'en_US:en', 01:41:43 INFO - 'LOGNAME': 'cltbld', 01:41:43 INFO - 'MAIL': '/var/mail/cltbld', 01:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:43 INFO - 'MOZ_NO_REMOTE': '1', 01:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:43 INFO - 'NO_EM_RESTART': '1', 01:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:43 INFO - 'PWD': '/builds/slave/test', 01:41:43 INFO - 'SHELL': '/bin/bash', 01:41:43 INFO - 'SHLVL': '1', 01:41:43 INFO - 'TERM': 'linux', 01:41:43 INFO - 'TMOUT': '86400', 01:41:43 INFO - 'USER': 'cltbld', 01:41:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:43 INFO - '_': '/tools/buildbot/bin/python'} 01:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:45 INFO - Downloading blobuploader-1.2.4.tar.gz 01:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:41:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:41:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:46 INFO - Downloading docopt-0.6.1.tar.gz 01:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:41:46 INFO - Installing collected packages: blobuploader, requests, docopt 01:41:46 INFO - Running setup.py install for blobuploader 01:41:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:41:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:41:46 INFO - Running setup.py install for requests 01:41:46 INFO - Running setup.py install for docopt 01:41:46 INFO - Successfully installed blobuploader requests docopt 01:41:46 INFO - Cleaning up... 01:41:46 INFO - Return code: 0 01:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:46 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:41:46 INFO - Using env: {'DISPLAY': ':0', 01:41:46 INFO - 'HOME': '/home/cltbld', 01:41:46 INFO - 'LANG': 'en_US.UTF-8', 01:41:46 INFO - 'LANGUAGE': 'en_US:en', 01:41:47 INFO - 'LOGNAME': 'cltbld', 01:41:47 INFO - 'MAIL': '/var/mail/cltbld', 01:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:47 INFO - 'MOZ_NO_REMOTE': '1', 01:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:47 INFO - 'NO_EM_RESTART': '1', 01:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:47 INFO - 'PWD': '/builds/slave/test', 01:41:47 INFO - 'SHELL': '/bin/bash', 01:41:47 INFO - 'SHLVL': '1', 01:41:47 INFO - 'TERM': 'linux', 01:41:47 INFO - 'TMOUT': '86400', 01:41:47 INFO - 'USER': 'cltbld', 01:41:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:47 INFO - '_': '/tools/buildbot/bin/python'} 01:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:47 INFO - Running setup.py (path:/tmp/pip-qlPHhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:47 INFO - Running setup.py (path:/tmp/pip-JyTuW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:47 INFO - Running setup.py (path:/tmp/pip-GVB2YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:47 INFO - Running setup.py (path:/tmp/pip-QT2A_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:47 INFO - Running setup.py (path:/tmp/pip-vDeiXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:47 INFO - Running setup.py (path:/tmp/pip-ESfyOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:47 INFO - Running setup.py (path:/tmp/pip-J2HqMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:47 INFO - Running setup.py (path:/tmp/pip-b5lTrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:47 INFO - Running setup.py (path:/tmp/pip-PxRXLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:47 INFO - Running setup.py (path:/tmp/pip-ReNHBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:47 INFO - Running setup.py (path:/tmp/pip-zCu53Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:48 INFO - Running setup.py (path:/tmp/pip-BHhl6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:48 INFO - Running setup.py (path:/tmp/pip-7iLEO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:48 INFO - Running setup.py (path:/tmp/pip-9ZDvaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:48 INFO - Running setup.py (path:/tmp/pip-nLf0nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:48 INFO - Running setup.py (path:/tmp/pip-9QpPZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:48 INFO - Running setup.py (path:/tmp/pip-PCGURI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:48 INFO - Running setup.py install for manifestparser 01:41:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:41:48 INFO - Running setup.py install for mozcrash 01:41:48 INFO - Running setup.py install for mozdebug 01:41:48 INFO - Running setup.py install for mozdevice 01:41:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:41:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:41:48 INFO - Running setup.py install for mozfile 01:41:48 INFO - Running setup.py install for mozhttpd 01:41:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozinfo 01:41:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozInstall 01:41:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozleak 01:41:49 INFO - Running setup.py install for mozlog 01:41:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for moznetwork 01:41:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozprocess 01:41:49 INFO - Running setup.py install for mozprofile 01:41:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozrunner 01:41:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:41:49 INFO - Running setup.py install for mozscreenshot 01:41:49 INFO - Running setup.py install for moztest 01:41:50 INFO - Running setup.py install for mozversion 01:41:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:41:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:50 INFO - Cleaning up... 01:41:50 INFO - Return code: 0 01:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:50 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:41:50 INFO - Using env: {'DISPLAY': ':0', 01:41:50 INFO - 'HOME': '/home/cltbld', 01:41:50 INFO - 'LANG': 'en_US.UTF-8', 01:41:50 INFO - 'LANGUAGE': 'en_US:en', 01:41:50 INFO - 'LOGNAME': 'cltbld', 01:41:50 INFO - 'MAIL': '/var/mail/cltbld', 01:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:50 INFO - 'MOZ_NO_REMOTE': '1', 01:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:50 INFO - 'NO_EM_RESTART': '1', 01:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:50 INFO - 'PWD': '/builds/slave/test', 01:41:50 INFO - 'SHELL': '/bin/bash', 01:41:50 INFO - 'SHLVL': '1', 01:41:50 INFO - 'TERM': 'linux', 01:41:50 INFO - 'TMOUT': '86400', 01:41:50 INFO - 'USER': 'cltbld', 01:41:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:50 INFO - '_': '/tools/buildbot/bin/python'} 01:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:41:50 INFO - Running setup.py (path:/tmp/pip-viCid2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:41:50 INFO - Running setup.py (path:/tmp/pip-8xBchW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:41:50 INFO - Running setup.py (path:/tmp/pip-6guFDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:41:50 INFO - Running setup.py (path:/tmp/pip-lGd3nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:41:50 INFO - Running setup.py (path:/tmp/pip-mwwGz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:41:50 INFO - Running setup.py (path:/tmp/pip-wKNAX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:41:50 INFO - Running setup.py (path:/tmp/pip-M1aPrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:41:50 INFO - Running setup.py (path:/tmp/pip-aEy5l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:41:51 INFO - Running setup.py (path:/tmp/pip-oXBcCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:41:51 INFO - Running setup.py (path:/tmp/pip-NqoDw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:41:51 INFO - Running setup.py (path:/tmp/pip-d2Ke_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:41:51 INFO - Running setup.py (path:/tmp/pip-N_Gci9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:41:51 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)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:41:51 INFO - Running setup.py (path:/tmp/pip-ZHHObF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:41:51 INFO - Running setup.py (path:/tmp/pip-41Sg1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:41:51 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)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:51 INFO - Running setup.py (path:/tmp/pip-MG2VJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:41:51 INFO - Running setup.py (path:/tmp/pip-8kD59w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:41:51 INFO - Running setup.py (path:/tmp/pip-3dtfUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:53 INFO - Downloading blessings-1.6.tar.gz 01:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:53 INFO - Installing collected packages: blessings 01:41:53 INFO - Running setup.py install for blessings 01:41:53 INFO - Successfully installed blessings 01:41:53 INFO - Cleaning up... 01:41:53 INFO - Return code: 0 01:41:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:54 INFO - Reading from file tmpfile_stdout 01:41:54 INFO - Current package versions: 01:41:54 INFO - argparse == 1.2.1 01:41:54 INFO - blessings == 1.6 01:41:54 INFO - blobuploader == 1.2.4 01:41:54 INFO - docopt == 0.6.1 01:41:54 INFO - functools32 == 3.2.3-2 01:41:54 INFO - jsonschema == 2.5.1 01:41:54 INFO - manifestparser == 1.1 01:41:54 INFO - mozInstall == 1.12 01:41:54 INFO - mozcrash == 0.17 01:41:54 INFO - mozdebug == 0.1 01:41:54 INFO - mozdevice == 0.48 01:41:54 INFO - mozfile == 1.2 01:41:54 INFO - mozhttpd == 0.7 01:41:54 INFO - mozinfo == 0.9 01:41:54 INFO - mozleak == 0.1 01:41:54 INFO - mozlog == 3.2 01:41:54 INFO - moznetwork == 0.27 01:41:54 INFO - mozprocess == 0.23 01:41:54 INFO - mozprofile == 0.28 01:41:54 INFO - mozrunner == 6.12 01:41:54 INFO - mozscreenshot == 0.1 01:41:54 INFO - mozsystemmonitor == 0.3 01:41:54 INFO - moztest == 0.7 01:41:54 INFO - mozversion == 1.4 01:41:54 INFO - psutil == 3.1.1 01:41:54 INFO - requests == 1.2.3 01:41:54 INFO - wsgiref == 0.1.2 01:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:54 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 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:41:54 INFO - Using env: {'DISPLAY': ':0', 01:41:54 INFO - 'HOME': '/home/cltbld', 01:41:54 INFO - 'LANG': 'en_US.UTF-8', 01:41:54 INFO - 'LANGUAGE': 'en_US:en', 01:41:54 INFO - 'LOGNAME': 'cltbld', 01:41:54 INFO - 'MAIL': '/var/mail/cltbld', 01:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:54 INFO - 'MOZ_NO_REMOTE': '1', 01:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:54 INFO - 'NO_EM_RESTART': '1', 01:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:54 INFO - 'PWD': '/builds/slave/test', 01:41:54 INFO - 'SHELL': '/bin/bash', 01:41:54 INFO - 'SHLVL': '1', 01:41:54 INFO - 'TERM': 'linux', 01:41:54 INFO - 'TMOUT': '86400', 01:41:54 INFO - 'USER': 'cltbld', 01:41:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:54 INFO - '_': '/tools/buildbot/bin/python'} 01:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:41:54 INFO - Cleaning up... 01:41:54 INFO - Return code: 0 01:41:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41: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'] in /builds/slave/test/build 01:41: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 01:41:54 INFO - Using env: {'DISPLAY': ':0', 01:41:54 INFO - 'HOME': '/home/cltbld', 01:41:54 INFO - 'LANG': 'en_US.UTF-8', 01:41:54 INFO - 'LANGUAGE': 'en_US:en', 01:41:54 INFO - 'LOGNAME': 'cltbld', 01:41:54 INFO - 'MAIL': '/var/mail/cltbld', 01:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:54 INFO - 'MOZ_NO_REMOTE': '1', 01:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:54 INFO - 'NO_EM_RESTART': '1', 01:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:54 INFO - 'PWD': '/builds/slave/test', 01:41:54 INFO - 'SHELL': '/bin/bash', 01:41:54 INFO - 'SHLVL': '1', 01:41:54 INFO - 'TERM': 'linux', 01:41:54 INFO - 'TMOUT': '86400', 01:41:54 INFO - 'USER': 'cltbld', 01:41:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:54 INFO - '_': '/tools/buildbot/bin/python'} 01:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:41:54 INFO - Cleaning up... 01:41:54 INFO - Return code: 0 01:41:54 INFO - Running post-action listener: _resource_record_post_action 01:41:54 INFO - Running post-action listener: _start_resource_monitoring 01:41:54 INFO - Starting resource monitoring. 01:41:54 INFO - ##### 01:41:54 INFO - ##### Finished create-virtualenv step (success) 01:41:54 INFO - ##### 01:41:54 INFO - ##### 01:41:54 INFO - ##### Running install step. 01:41:54 INFO - ##### 01:41:54 INFO - Running pre-action listener: _resource_record_pre_action 01:41:54 INFO - Running main action method: install 01:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:41:54 INFO - Reading from file tmpfile_stdout 01:41:54 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:41:54 INFO - Reading from file tmpfile_stdout 01:41:54 INFO - Output received: 01:41:54 INFO - Usage: mozinstall [options] installer 01:41:54 INFO - Options: 01:41:54 INFO - -h, --help show this help message and exit 01:41:54 INFO - -d DEST, --destination=DEST 01:41:54 INFO - Directory to install application into. [default: 01:41:54 INFO - "/builds/slave/test"] 01:41:54 INFO - --app=APP Application being installed. [default: firefox] 01:41:54 INFO - mkdir: /builds/slave/test/build/application 01:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:42:11 INFO - Reading from file tmpfile_stdout 01:42:11 INFO - Output received: 01:42:11 INFO - /builds/slave/test/build/application/firefox/firefox 01:42:11 INFO - Running post-action listener: _resource_record_post_action 01:42:11 INFO - ##### 01:42:11 INFO - ##### Finished install step (success) 01:42:11 INFO - ##### 01:42:11 INFO - ##### 01:42:11 INFO - ##### Running run-tests step. 01:42:11 INFO - ##### 01:42:11 INFO - Running pre-action listener: _resource_record_pre_action 01:42:11 INFO - Running main action method: run_tests 01:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:42:11 INFO - Python 2.7.3 01:42:11 INFO - Return code: 0 01:42:11 INFO - grabbing minidump binary from tooltool 01:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:11 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 0x2057570>, '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 0x2058470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:42:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:42:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:42:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:42:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:42:11 INFO - Return code: 0 01:42:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:42:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:42:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:42:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:42:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:42:11 INFO - Using env: {'DISPLAY': ':0', 01:42:11 INFO - 'HOME': '/home/cltbld', 01:42:11 INFO - 'LANG': 'en_US.UTF-8', 01:42:11 INFO - 'LANGUAGE': 'en_US:en', 01:42:11 INFO - 'LOGNAME': 'cltbld', 01:42:11 INFO - 'MAIL': '/var/mail/cltbld', 01:42:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:42:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:11 INFO - 'MOZ_NO_REMOTE': '1', 01:42:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:11 INFO - 'NO_EM_RESTART': '1', 01:42:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:11 INFO - 'PWD': '/builds/slave/test', 01:42:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:42:11 INFO - 'SHELL': '/bin/bash', 01:42:11 INFO - 'SHLVL': '1', 01:42:11 INFO - 'TERM': 'linux', 01:42:11 INFO - 'TMOUT': '86400', 01:42:11 INFO - 'USER': 'cltbld', 01:42:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172', 01:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:11 INFO - '_': '/tools/buildbot/bin/python'} 01:42:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:42:11 INFO - mozversion application_buildid: 20160717001753 01:42:11 INFO - mozversion application_changeset: ef5f932101e5b833b2429407cb0873471b4d764e 01:42:11 INFO - mozversion application_display_name: Nightly 01:42:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:42:11 INFO - mozversion application_name: Firefox 01:42:11 INFO - mozversion application_remotingname: firefox 01:42:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:42:11 INFO - mozversion application_vendor: Mozilla 01:42:11 INFO - mozversion application_version: 50.0a1 01:42:11 INFO - mozversion platform_buildid: 20160717001753 01:42:11 INFO - mozversion platform_changeset: ef5f932101e5b833b2429407cb0873471b4d764e 01:42:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:42:11 INFO - mozversion platform_version: 50.0a1 01:42:11 INFO - using testdate: 1468744931 01:42:11 INFO - actual date: 1468744931 01:42:11 INFO - starting webserver on 'localhost:39994' 01:42:11 INFO - SUITE-START | Running 2 tests 01:42:11 INFO - TEST-START | dromaeo_css 01:42:11 INFO - operating with platform_type : linux_ 01:42:11 INFO - Initialising browser for dromaeo_css test... 01:42:11 INFO - TEST-INFO | started process 7904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsD0r2/profile http://localhost:39994/getInfo.html) 01:42:16 INFO - PROCESS | 7904 | __metrics Screen width/height:1600/1200 01:42:16 INFO - PROCESS | 7904 | colorDepth:24 01:42:16 INFO - PROCESS | 7904 | Browser inner width/height: 1024/697 01:42:16 INFO - PROCESS | 7904 | __metrics 01:42:17 ERROR - PROCESS | 7904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 01:42:18 INFO - TEST-INFO | 7904: exit 0 01:42:18 INFO - Browser initialized. 01:42:18 INFO - Running cycle 1/1 for dromaeo_css test... 01:42:18 INFO - TEST-INFO | started process 8024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsD0r2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:42:30 INFO - PROCESS | 8024 | RSS: Main: 169127936 01:42:30 INFO - PROCESS | 8024 | 01:43:19 INFO - PROCESS | 8024 | 1468744999816 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:45:31 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39994/tests/dromaeo/cssquery-ext.html) 01:45:32 INFO - PROCESS | 8024 | RSS: Main: 173285376 01:45:32 INFO - PROCESS | 8024 | 01:48:35 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-ext.html (next: http://localhost:39994/tests/dromaeo/cssquery-jquery.html) 01:48:35 INFO - PROCESS | 8024 | RSS: Main: 168542208 01:48:35 INFO - PROCESS | 8024 | 01:51:37 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39994/tests/dromaeo/cssquery-mootools.html) 01:51:38 INFO - PROCESS | 8024 | RSS: Main: 172109824 01:51:38 INFO - PROCESS | 8024 | 01:54:40 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39994/tests/dromaeo/cssquery-prototype.html) 01:54:40 INFO - PROCESS | 8024 | RSS: Main: 167088128 01:54:40 INFO - PROCESS | 8024 | 01:57:43 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39994/tests/dromaeo/cssquery-yui.html) 01:57:44 INFO - PROCESS | 8024 | RSS: Main: 169283584 01:57:44 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:39994/tests/dromaeo/cssquery-yui.html (next: http://localhost:39994/tests/dromaeo/cssquery-dojo.html) 02:00:46 INFO - PROCESS | 8024 | RSS: Main: 170127360 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | __start_tp_report 02:00:46 INFO - PROCESS | 8024 | _x_x_mozilla_page_load 02:00:46 INFO - PROCESS | 8024 | _x_x_mozilla_page_load_details 02:00:46 INFO - PROCESS | 8024 | |i|pagename|runs| 02:00:46 INFO - PROCESS | 8024 | |0;dojo.html;2650.218185635237;2684.5436275833113;2695.555233386491;2720.768734657554;2729.304027472995;4826.710397376156;4874.244492103725;4920.729359885205;4941.67879087859;4951.455339912607;4617.984043510422;4686.039361930804;4696.741679207642;4908.97545512272;4927.556519913207;4273.358996150587;4335.9566404335865;4364.585364390377;4406.383106365111;4407.845725399612;42.227655322365045;4206.137741762931;4307.719998200123;4360.236958532244;4429.667774916878;4424.535423780505;4427.889302767424;4454.8886277842985;4484.125595508877;4497.100579884036;4457.24226881431;4461.42001539801;4487.483939346984;4504.234280172379;4527;4298.46269216348;4329.220740266751;4329.9567004329865;4344.174606824693;4450.777461126963;4710.481846996828;4729.929051064237;4736.242201247818;4737.099951009297;4745.762711864393;5012.799488020475;5055.6713813602;5077.289179514871;5077.898442031175;5125.641205115643;5245.213218017289;5250.159974404115;5253.789848406059;5262.447443018466;5267.604929630293;4854.7572621369145;4949.381327334083;4958.752062396902;4959.553640172329;4997.025580011936;5265.183896496049;5326.5206131447585;5435.42927992563;5438.972805136028;5444.537214336826;5135.97432012845;5136.614753893473;5145.9485405146215;5149.124648809711;5192.584593232532;5201.687898726089;5248.448912864094;5250.7637156328055;5251.868703282372;5298.735063246822;4990.525900039491;5115.616328775282;5125.820596279113;5153.974230128825;5195.220716892496;5152.613553983466;5154.840160963753;5164.406093299319;5172.663776854568;5205.401378841406;4436.733795972252;4446.177457170434;4461.776911154429;4463.776811159429;4508.45898492183;3725;3788.6021967692996;3805.657490825839;3832.693384529231;3849.3840985442193;4261.190373828963;4406.2949928012;4415.381846541487;4424.446944131983;4445.844395446144;5148.791691631745;5162.819301324435;5181.81863634771;5184.326037615086;5228.08508511009;4401.625861801719;4423.889402764892;4431.069475410135;4464.553544645574;4471.955280447154;4665.4168228971375;4673.509281525459;4679.602233810164;4684.297355396718;4720.811167553328;4844.346013288232;4895.7062576245535;4899.902001960012;4927.802887884444;4939.283803848493;4981.875453113701;5146.305248791366;5223.947760522498;5234.162533994542;5238.109521381451;4876.195427754381;4903.95096049035;4908.582770464551;4911.950880491149;4971.527704868032;5127.077126117335;5130.5639020682165;5153.819616313411;5162.432132465501;5162.767675454538;5190.68855868634;5210.6613070150315;5241.868953276198;5276.973615132053;5298.576113910801;5071.340725705634;5075.3402057732255;5086.7710953007945;5097.209932460474;5138.152204886302;4808.567228949271;5042.09242336383;5067.721275329893;5070.746462676925;5102.69383836971;4889.462159162418;4896.90206195867;4932.506749325039;4957.776900039579;4998.2502624606595;5087.3386459759995;5090.847274581768;5091.92362114576;5113.233015047773;5113.51421614946;4811.975940120417;4930.975345123252;4955.306257123933;4979.103761322996;4981.4769449207315 02:00:46 INFO - PROCESS | 8024 | |1;ext.html;547.4607511601072;560.6972234993103;575.0683892094808;575.9164921086442;581.2617975171535;35512;40082.398764018566;40092.59907400929;40182.397264041065;40259.396109058354;40540;40978.7951060245;41072.79463602678;41175.38236926449;41259.174816503655;7620.352270057052;7771.145174030852;7786.805329866742;7806.2193780621765;7818.061832580099;7717.2668596483245;7788.299053085221;7825.9608701956695;7831.569263690495;7844.450888437812;7807.258310460497;7866.292033716964;7900.486468379566;7910;7910.4462687611895;7787.415943804209;7810.375169986388;7814.023247094114;7822.804429889241;7840.882386764203;7756.379489640815;7790.259925307087;7823.530588164728;7827.804304892366;7833.804154896173;37730.245395091944;38092.23815523702;38211.80894095512;38301;38318;2947.6168098147105;3165.9525107123413;3187.235063584746;3192.537082123102;3201.599800024997;29137.56293655597;29167.41665166685;29312.413751724845;29576.11271661832;29923.401531969455;3359.81521016344;3384.9323013539592;3396.5584474018465;3399.456087026089;3471.826408679581;250861;251038;252328;252384.73807631028;252620;31696.207594809854;51585.2262216067;51690;51734;51824.74087629538;31742;33738.49392259118;33824.1543961398;33903;33924.1518962023;13319.40062697181;13416.262105584286;13465.528706495226;13491;13491.460341586228;11083.168762342857;11121;11194;11206.719832004102;11258;7880.921190788134;7897.960510197528;7917.564533950688;7941.444098913021;7955.323797477164;2979.6722360540325;3136.81179129253;3146.921326966844;3169.793963392372;3170.936581268362;900.4372267332917;916.9724908252763;939.6006697153682;945.645382981382;1034.7568321444455;27875.860620696767;28172;28824.279393015342;29128.708712913023;29222.269443263664;918.3112665500875;948.1656142594472;972.7470857577081;1023.5752162852482;1027.5632856036304;14354.712905741826;14547.854521454861;14619.853801462063;14810.185439800915;14838.851611483748;394232;394796;398468;399180;401968;48536;49028.26457603139;49172;49186.26220606694;49410;1133.8752737198902;1160.2690305107897;1167.177140116216;1180.474688763492;1183.0771997841525;25676.229713108638;27177.86411068011;27494.587581186697;27578.724212758418;28401.28996775097;42961.78519107385;47196.820079496916;47535;47542;47573;366801;369910;371395;372456;374162;37862.24275514529;38057.80971095127;38604.613953861226;38707;39424.40863387109;42628.36057459203;43057.70826875199;43362.349564755925;43435.782821086956;44057;34235.315293693486;36988;37002.44496332611;37112;37294.81352593219;36690.44964325484;36746.448803268504;36845.81577092098;37085.62914370822;37630.81184594169;32873.83563082265;35464.822675886455;37943.81028094842;38667.80666096652;38781;31874.043778686675;32427;32794.50808237831;32917.50623740598;33024.66975330216;25494.490110197323;25645.61531577065;25704.742952570236;26015.609765853147;26062.218133456026 02:00:46 INFO - PROCESS | 8024 | |2;jquery.html;369.52700543304564;377.45457813459547;378.6005763919065;387.6317498376543;389.92006638639083;16247.268872900719;16987.57531061724;18043.00763458011;18044.458666240032;18537.443876683687;10920.617778377758;11271.436428178578;11485.368304743235;11542.769144617103;11593.130515211371;4266.317389217726;4754.524547545244;4917.7541122943885;4923.483034281403;4926.11329960607;4771.212749896263;4814.590759785422;4821.228603423453;4825.155597770394;4826.0830442215865;4786.066716990188;4807.61539076873;4810.11012962603;4856.125897338496;4858.4898585648525;4822.035592881438;4826.927596086061;4852.660313778037;4855.878603034935;4864.708117512942;4527.366168736379;4618.953810461886;4719.834805781781;4748.691335063209;4774.880627984294;12801;12866.228026318451;12873.806892896613;12955.5465558705;18325.816741832543;2015.475976246172;2022.4943764058985;2048.6414877396396;2416.395901024744;2446.608542633188;9585.808283834354;9643.324967252294;12543.498260069586;13290.933545332307;13356.332183390792;1730.4722059771764;1775.7513948047153;1781.340903865578;1797.1822820616587;1814.3921786201638;71364.2863571368;71693.64153179253;72105.27894721038;74410;74787;10126.594936202617;10129.088382045504;10260;10342.172626189888;10527.894721052691;14116.153030817979;14136.15183089018;14181.85818141826;14280.50018249377;14289.356978935974;7233.683242816525;7400.5189662671755;7460.776176714708;7535.660895259726;7542.811429714301;6699.263081061079;6700.430463410567;6931.1682598088555;6999.09011828459;7171.641417929082;4390.165868484977;4407.096545208289;4413.646908247332;4422.358757980075;4462.9107417851465;1813.963720725578;1826.8538516918616;1848.491664792166;1861.9069046547888;1899.335232668555;804.7947773317767;892.7991201979632;898.6405437824923;908.3051465628799;932.6316105138568;17057;17517.40081658579;17755.911220443813;17757.556061098578;17926.462206133838;797.1510341486298;826.5412695953803;856.1866227084171;890.844102282098;898.7483504618717;9741.464219467998;9744.707658770249;9810.852837207447;9872.40765554069;9872.703818885446;366054;366954;387711;390705;395323;80949;82440;82457.17542824495;83030.58484707538;83803;913.3515204205089;914.7255823252998;918.169057003413;919.3748251189255;928.679605536089;15255.771163432779;15350.539483815057;15516.22418879029;15669.138197399252;15875.206239688201;35760.821195893855;36670.8166459166;37440.438393423574;37483.81258093692;37811.81094094622;49730;52180;52331;52524.73737631287;52803.471965281395;7495.43784216175;7928.08826984881;7946.8807967881685;7996.880046799419;8059.032916050111;8968.192862642394;11346.659600212008;11904.761904761683;11929.03170976779;12448.813267801172;9874.654387096418;9912;10652.254342195973;10711.464426778473;10914.50884710174;10012;10183.541740621542;10221.386716797017;10229.74425639365;10304.278700490893;9879.259055571005;10025.699229023141;10043.949780251052;10323.896761032294;11006.724831879266;7702.191269916578;7721.498102623312;7780.221977802401;7857.017872765904;7996.32031277348;8753.34349923771;9826.508674566387;10265.58937642486;10445.425501597485;10685.893141068489 02:00:46 INFO - PROCESS | 8024 | |3;mootools.html;1376.855430179831;1419.3612874206606;1505.330128092999;1695.524534180097;1706.6757316109945;6586.769463068794;7507.812304692378;7517.812054698636;8031.237032481912;8069.112397636262;7853.528788272693;8078.232567906054;8140.1452847451055;8154.836903261946;8160.6327715252955;2202.031106313217;2245.393743689203;2245.9438514037115;2249.167807911067;2255.0979608156786;2219.766924472923;2239.5632851593946;2242.6187548116777;2244.8091912187483;2245.14684419921;2176.9891150544227;2183.4977955070344;2198.263581700124;2202.482416632098;2202.8237740980685;2151.848760912912;2161.297578287063;2170.8806015669134;2179.2917301876955;2183.7816218378193;2169.39257008038;2178.3247193370107;2180.7056047433553;2182.6835108909277;2193.2981445937307;7972.880406793903;7981.1220765715725;7994.360451163893;7995.360371170293;8028.4781489203015;4542.205114105019;4635.930461043087;4689.038747056845;4689.366935463703;4696.3894693689945;2721;2754.5317296059716;2765.363966287745;2790.1071657069747;2797.2727090956496;847.4788005376711;869.4522450855984;882.4661080046544;895.3061377432476;896.7758060484879;10646;10717.464126793708;10749.731256718567;10753.085987691056;10775.784484310348;4050.1292222171787;4258.893527661771;4258.914821703549;4324.978375108104;4339.1972485090355;9091.454512729257;9110.863337049817;9135.177833994972;9137.543122843832;9173.816523669622;4680.391549098664;4686.226772582554;4699.271612900006;4710.152172608963;4737;3589.533360663097;4262.50981137167;4324.56754324565;4334.869953901388;4416.492103408085;3602.9819850900576;3693.5567731872347;3709.4992176056426;3737.794421306854;3762.9059273518383;1225.209739717877;1229.8093795461718;1231.612042206702;1233.8827811357908;1237.7153254751458;671.5366397185926;726.6512074204411;808.9878651820227;831.9974430810859;832.825106727594;5104.285400043997;5178.6116041297055;5452.945470545244;5585.357683866408;5857.384974577608;857.8884744983112;869.3740506835069;885.9867101993475;891.7101941868789;896.3277541843618;3216.388886111678;3562.4478205877613;3565.16218688608;3574.9285014299567;3588.3720348939355;9687.128158465772;10077.193824494023;10193.388396696222;10211.234157438073;10221.540030698636;9989.60041598328;10108.646197383056;10118.949405253074;10126.746831329276;10134.037266459674;7144.463940252871;7241.348278654947;7449.962750186322;7457.701691932262;7654.7320843769085;5418.403975562606;5428.83713488596;5520.861978450571;5558.055130627884;5668.1214411764595;8659.090795466638;8788.692395766118;8822.426542274732;8873.467591944504;9042;8818;8821.294296456397;8883.955580222058;8937.06160853101;8981.191692747683;5915.319738230159;6562.868742625216;6740.831479213059;6902.827429314308;7096.53872498286;7856.607169641609;7873.37013038967;7928.08826984881;7941.483803552751;7959.403044771781;6821.522493425413;6927.307269273234;7051.541649792747;7216.278372162742;7227.349538541556;6858.862822743617;6889;7044.225135235018;7056.506044577036;7137;6324.936750632435;6342.23893132827;6345.8730825384155;6363.395477429637;6401.519886008475;4567.794449249725;4574.794134264032;4591.862244132682;4609.492955774795;4617.51516090819;4538.29656403258;4559.886002849956;4593.586577208067;4627.236505976476;4661.743604101672 02:00:46 INFO - PROCESS | 8024 | |4;prototype.html;301.84153319507243;307.69691853524284;313.0779853331937;316.49993011042557;316.54101552748523;4963.404391473019;4980.950190498094;5085.626880742202;5200.50595193457;5226.738663066846;4999.175136102548;5010.849674509762;5038.193888977764;5038.571721403676;5041.571466425349;3978.76127432355;3983.541892682342;3991.820368083443;3995.3407687731487;4020.6582440492593;3929.469521614574;4007.438958545791;4011.2980228460046;4032.213718324928;4036.3340048891896;3972.9006774830714;3991.680665546764;3995.9200815983663;3996.700247481436;3997.2205419943125;3988.3419235826054;4003.2994226010624;4005.859794907164;4006.83972641094;4012.9598704013024;3540.982295088508;3557.7547858249404;3560.8041557714314;3564.0733409313507;3578.6063533011347;4854.878628034292;4976.328195693572;5014.623903207274;5022.321986531808;5050.409121126833;4562.338460923181;4580.7938642761155;4583.449986001668;4595.655325850575;4632.10493441599;5364.497940576644;5390.21841832932;5405.5135037846385;5405.972970135163;5407.297051383295;3794.753341032824;3827.158025234444;3832.42513622956;3851.5763266040713;3876.5348158220913;5546.972265138689;5572.888542229173;5603.80386686464;5618.634788738719;5633.943660563383;3953.4267531207815;3957.742746721454;3963.742356746802;3964.147708242742;3968.543617484026;3862.4013277941963;4014.518257809023;4018.4374187613757;4025.9194816103513;4057.127717540684;4495;4502.144592527409;4506.752128632957;4518.4126063612175;4586.449626044896;5270.947290527046;5298.443663415363;5326.6537675050995;5348.91976620351;5354.812581559627;1273.2678709741936;1363.8363396392497;1386.2237147197602;1389.3817251323064;1398.9440422383195;932.5244125496046;951.1344676344494;957.1911734584265;964.5418426247617;965.1035714820412;4589.196890544142;4591.288350305641;4595.839145629954;4609.838655647036;4620.953790462052;5383.811566595229;5410.48600382963;5443.346798384219;5493.862653433696;5498.917516237259;4441.977790111094;4587.243104887723;4638.744869032235;4653.511381304914;4654.720716757005;2909.3163106669917;2941.4558306713325;2948.7051294870344;2958.304798372381;2968.539876319174;5226.163813789775;5253.4221235664045;5258.290130832289;5262.131748261494;5284.81503147388;5359;5713.714314284269;5718.199452076713;5728.598998070179;5762.2509073820975;5239.528442440199;5244.325394049062;5244.6853188809555;5255.343082114736;5289.57683385336;5543;5546.251256080377;5587.469190426903;5600.299962504687;5621.943780562142;5210.452902445189;5492.423295553909;5496.148097044965;5496.532794712334;5506.971165858842;5230.503102205284;5245.737713114406;5252.111338763589;5259.894802104013;5277.762500687555;3820.6752426042985;3893.4743809585343;3926.2540117377607;3932.842686292516;3933.4886464759397;5232.68603883753;5386.245925570345;5575.498205161392;5586.720663966704;5586.776528938797;5385.838424847261;5398.2982212312145;5409.918851217156;5421.864453388697;5422.62041657096;5437.972810135924;5445;5446.754896029609;5447.564194864481;5453.072977593898;5063.898722025612;5291.391489978548;5291.735413229246;5305;5326.41409444953;5361.490658387447;5373.596980226577;5382.892342153056;5411.485908838654;5439.5104440600535;5224.843254702365;5265;5276.0214919405225;5283.788648454172;5291.126964051043 02:00:46 INFO - PROCESS | 8024 | |5;yui.html;583.4224118123058;583.9795607153748;604.1964187630449;625.3996163682864;658.3350815676166;12770.169938953974;13450;13463.663408414783;13492.865071349308;13500.729985400287;12150.331731754772;12348.629541113782;12565.37173141344;13030.478780848778;13088.345582720873;760.7033257029763;778.9922100779005;779.123486078162;784.1413652050995;787.1498781316193;792.5442870349543;792.7859477940953;793.738066438074;793.8015496125969;795.5942469340649;830.1822704635929;831.6881169561415;832.9042160151599;834.6285902773268;836.3016880904452;820.0856045509244;822.6873787960596;823.390690888744;824.9216324449168;826.9917300826975;602.6143268308242;603.2399177036965;607.4684650930436;610.6885488400948;610.9725062372204;11044.447777611087;11082.501287442085;11160.720981975435;11177.66467005991;11188.38463884486;10817.459127043616;10868.239223254375;11021.83467247992;11046;11276.492557834836;8935.719506919346;9178;9199.494027828467;9301.90698093024;9306.348555601111;3251.4797632378704;3269.1500209945348;3314.2211580278617;3317.701406873393;3378.729701623864;57625.13562296527;58256;58653;59334;61079.69460152715;8265.917340826634;8345.248927596545;8373.539455330016;8551.315894728406;8568.657253709782;16405.1797410129;16462.341506339853;16471.25879335433;16488.422905198502;16615;6196.783112591038;6489.772857949949;6835.829104272433;6935.271796461399;6977.651117444209;3526.964730352715;3620.981895090508;3725.906852328659;3742.214135031619;3825.5600605930117;2722.4146808435885;2823.9011634593103;2835.376217232206;2837.446697893932;2848.9715102848704;494;502.88936433984463;504.68961588622733;511.88482591416636;513.3301042140043;497.6317525031523;522.9633925625246;562.2746656812666;565.366789196103;585.6661702829432;7165.570065796069;7232.276772322725;7255.492115551966;7414.666340014713;7471.850562988819;524.9317588713519;526.3867594252729;537.2022546518417;537.9596530260246;564.7232855900579;3532.6290739472497;3542.4155014422845;3594.6405359463843;3643.7813731176216;3710.925781484409;89312.5534372324;93162.53418732862;95711.52144239235;96022;96344;81105;85461.57269213613;85648;85840.57079714561;85977.5701121503;73379.63310183414;74455.25544744592;74788.62605686937;75556;76038;6871.9312806873295;6886.8622627546165;6992.510524263253;7194.100737407824;7218.783436496913;43849.56150438455;43910.34134488049;44432.777836111905;45565;45799.542004580864;62822.37177628165;63236.83815809283;63343.36656633559;63367;63437.36562634315;8933.910660893307;8941.061188575106;8952.462852228888;9225.815483690423;9232.723018309462;9475.526223688927;9626.66306679263;9671.951640242036;9899.95050024774;9938.602455901682;8196.631151598072;8307.501549907025;8322.750317490485;8365.456245344034;8400.453970492143;8087.83824323522;8248.422610417214;8294.212049855254;8409.2431681149;8757.036725960012;8510.404271700922;8938.061503542034;9019.458832470073;9036.548172591476;9069.093090690878;7721.7683469496005;7732.961335193288;7862.135165131716;7862.861224368331;7896.210378962058;7404.888926665996;7711.6915323388685;7835.882461762964;7909.129995700353;7979.880301795594 02:00:46 INFO - PROCESS | 8024 | __end_tp_report 02:00:46 INFO - PROCESS | 8024 | __start_cc_report 02:00:46 INFO - PROCESS | 8024 | _x_x_mozilla_cycle_collect,405 02:00:46 INFO - PROCESS | 8024 | __end_cc_report 02:00:46 INFO - PROCESS | 8024 | __startTimestamp1468746046875__endTimestamp 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | ------- Summary: start ------- 02:00:46 INFO - PROCESS | 8024 | Number of tests: 6 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#0] dojo.html Cycles:165 Average:4756.67 Median:4932.51 stddev:636.62 (12.9%) stddev-sans-first:616.75 02:00:46 INFO - PROCESS | 8024 | Values: 2650.2 2684.5 2695.6 2720.8 2729.3 4826.7 4874.2 4920.7 4941.7 4951.5 4618.0 4686.0 4696.7 4909.0 4927.6 4273.4 4336.0 4364.6 4406.4 4407.8 42.2 4206.1 4307.7 4360.2 4429.7 4424.5 4427.9 4454.9 4484.1 4497.1 4457.2 4461.4 4487.5 4504.2 4527.0 4298.5 4329.2 4330.0 4344.2 4450.8 4710.5 4729.9 4736.2 4737.1 4745.8 5012.8 5055.7 5077.3 5077.9 5125.6 5245.2 5250.2 5253.8 5262.4 5267.6 4854.8 4949.4 4958.8 4959.6 4997.0 5265.2 5326.5 5435.4 5439.0 5444.5 5136.0 5136.6 5145.9 5149.1 5192.6 5201.7 5248.4 5250.8 5251.9 5298.7 4990.5 5115.6 5125.8 5154.0 5195.2 5152.6 5154.8 5164.4 5172.7 5205.4 4436.7 4446.2 4461.8 4463.8 4508.5 3725.0 3788.6 3805.7 3832.7 3849.4 4261.2 4406.3 4415.4 4424.4 4445.8 5148.8 5162.8 5181.8 5184.3 5228.1 4401.6 4423.9 4431.1 4464.6 4472.0 4665.4 4673.5 4679.6 4684.3 4720.8 4844.3 4895.7 4899.9 4927.8 4939.3 4981.9 5146.3 5223.9 5234.2 5238.1 4876.2 4904.0 4908.6 4912.0 4971.5 5127.1 5130.6 5153.8 5162.4 5162.8 5190.7 5210.7 5241.9 5277.0 5298.6 5071.3 5075.3 5086.8 5097.2 5138.2 4808.6 5042.1 5067.7 5070.7 5102.7 4889.5 4896.9 4932.5 4957.8 4998.3 5087.3 5090.8 5091.9 5113.2 5113.5 4812.0 4931.0 4955.3 4979.1 4981.5 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#1] ext.html Cycles:180 Average:48639.60 Median:205896.41 stddev:91431.41 (44.4%) stddev-sans-first:91616.60 02:00:46 INFO - PROCESS | 8024 | Values: 547.5 560.7 575.1 575.9 581.3 35512.0 40082.4 40092.6 40182.4 40259.4 40540.0 40978.8 41072.8 41175.4 41259.2 7620.4 7771.1 7786.8 7806.2 7818.1 7717.3 7788.3 7826.0 7831.6 7844.5 7807.3 7866.3 7900.5 7910.0 7910.4 7787.4 7810.4 7814.0 7822.8 7840.9 7756.4 7790.3 7823.5 7827.8 7833.8 37730.2 38092.2 38211.8 38301.0 38318.0 2947.6 3166.0 3187.2 3192.5 3201.6 29137.6 29167.4 29312.4 29576.1 29923.4 3359.8 3384.9 3396.6 3399.5 3471.8 250861.0 251038.0 252328.0 252384.7 252620.0 31696.2 51585.2 51690.0 51734.0 51824.7 31742.0 33738.5 33824.2 33903.0 33924.2 13319.4 13416.3 13465.5 13491.0 13491.5 11083.2 11121.0 11194.0 11206.7 11258.0 7880.9 7898.0 7917.6 7941.4 7955.3 2979.7 3136.8 3146.9 3169.8 3170.9 900.4 917.0 939.6 945.6 1034.8 27875.9 28172.0 28824.3 29128.7 29222.3 918.3 948.2 972.7 1023.6 1027.6 14354.7 14547.9 14619.9 14810.2 14838.9 394232.0 394796.0 398468.0 399180.0 401968.0 48536.0 49028.3 49172.0 49186.3 49410.0 1133.9 1160.3 1167.2 1180.5 1183.1 25676.2 27177.9 27494.6 27578.7 28401.3 42961.8 47196.8 47535.0 47542.0 47573.0 366801.0 369910.0 371395.0 372456.0 374162.0 37862.2 38057.8 38604.6 38707.0 39424.4 42628.4 43057.7 43362.3 43435.8 44057.0 34235.3 36988.0 37002.4 37112.0 37294.8 36690.4 36746.4 36845.8 37085.6 37630.8 32873.8 35464.8 37943.8 38667.8 38781.0 31874.0 32427.0 32794.5 32917.5 33024.7 25494.5 25645.6 25704.7 26015.6 26062.2 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#2] jquery.html Cycles:180 Average:24086.43 Median:4418.00 stddev:63321.25 (1433.3%) stddev-sans-first:63473.85 02:00:46 INFO - PROCESS | 8024 | Values: 369.5 377.5 378.6 387.6 389.9 16247.3 16987.6 18043.0 18044.5 18537.4 10920.6 11271.4 11485.4 11542.8 11593.1 4266.3 4754.5 4917.8 4923.5 4926.1 4771.2 4814.6 4821.2 4825.2 4826.1 4786.1 4807.6 4810.1 4856.1 4858.5 4822.0 4826.9 4852.7 4855.9 4864.7 4527.4 4619.0 4719.8 4748.7 4774.9 12801.0 12866.2 12873.8 12955.5 18325.8 2015.5 2022.5 2048.6 2416.4 2446.6 9585.8 9643.3 12543.5 13290.9 13356.3 1730.5 1775.8 1781.3 1797.2 1814.4 71364.3 71693.6 72105.3 74410.0 74787.0 10126.6 10129.1 10260.0 10342.2 10527.9 14116.2 14136.2 14181.9 14280.5 14289.4 7233.7 7400.5 7460.8 7535.7 7542.8 6699.3 6700.4 6931.2 6999.1 7171.6 4390.2 4407.1 4413.6 4422.4 4462.9 1814.0 1826.9 1848.5 1861.9 1899.3 804.8 892.8 898.6 908.3 932.6 17057.0 17517.4 17755.9 17757.6 17926.5 797.2 826.5 856.2 890.8 898.7 9741.5 9744.7 9810.9 9872.4 9872.7 366054.0 366954.0 387711.0 390705.0 395323.0 80949.0 82440.0 82457.2 83030.6 83803.0 913.4 914.7 918.2 919.4 928.7 15255.8 15350.5 15516.2 15669.1 15875.2 35760.8 36670.8 37440.4 37483.8 37811.8 49730.0 52180.0 52331.0 52524.7 52803.5 7495.4 7928.1 7946.9 7996.9 8059.0 8968.2 11346.7 11904.8 11929.0 12448.8 9874.7 9912.0 10652.3 10711.5 10914.5 10012.0 10183.5 10221.4 10229.7 10304.3 9879.3 10025.7 10043.9 10323.9 11006.7 7702.2 7721.5 7780.2 7857.0 7996.3 8753.3 9826.5 10265.6 10445.4 10685.9 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#3] mootools.html Cycles:180 Average:5220.60 Median:4704.71 stddev:2945.48 (62.6%) stddev-sans-first:2939.57 02:00:46 INFO - PROCESS | 8024 | Values: 1376.9 1419.4 1505.3 1695.5 1706.7 6586.8 7507.8 7517.8 8031.2 8069.1 7853.5 8078.2 8140.1 8154.8 8160.6 2202.0 2245.4 2245.9 2249.2 2255.1 2219.8 2239.6 2242.6 2244.8 2245.1 2177.0 2183.5 2198.3 2202.5 2202.8 2151.8 2161.3 2170.9 2179.3 2183.8 2169.4 2178.3 2180.7 2182.7 2193.3 7972.9 7981.1 7994.4 7995.4 8028.5 4542.2 4635.9 4689.0 4689.4 4696.4 2721.0 2754.5 2765.4 2790.1 2797.3 847.5 869.5 882.5 895.3 896.8 10646.0 10717.5 10749.7 10753.1 10775.8 4050.1 4258.9 4258.9 4325.0 4339.2 9091.5 9110.9 9135.2 9137.5 9173.8 4680.4 4686.2 4699.3 4710.2 4737.0 3589.5 4262.5 4324.6 4334.9 4416.5 3603.0 3693.6 3709.5 3737.8 3762.9 1225.2 1229.8 1231.6 1233.9 1237.7 671.5 726.7 809.0 832.0 832.8 5104.3 5178.6 5452.9 5585.4 5857.4 857.9 869.4 886.0 891.7 896.3 3216.4 3562.4 3565.2 3574.9 3588.4 9687.1 10077.2 10193.4 10211.2 10221.5 9989.6 10108.6 10118.9 10126.7 10134.0 7144.5 7241.3 7450.0 7457.7 7654.7 5418.4 5428.8 5520.9 5558.1 5668.1 8659.1 8788.7 8822.4 8873.5 9042.0 8818.0 8821.3 8884.0 8937.1 8981.2 5915.3 6562.9 6740.8 6902.8 7096.5 7856.6 7873.4 7928.1 7941.5 7959.4 6821.5 6927.3 7051.5 7216.3 7227.3 6858.9 6889.0 7044.2 7056.5 7137.0 6324.9 6342.2 6345.9 6363.4 6401.5 4567.8 4574.8 4591.9 4609.5 4617.5 4538.3 4559.9 4593.6 4627.2 4661.7 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#4] prototype.html Cycles:180 Average:4463.13 Median:5045.99 stddev:1293.06 (25.6%) stddev-sans-first:1258.40 02:00:46 INFO - PROCESS | 8024 | Values: 301.8 307.7 313.1 316.5 316.5 4963.4 4981.0 5085.6 5200.5 5226.7 4999.2 5010.8 5038.2 5038.6 5041.6 3978.8 3983.5 3991.8 3995.3 4020.7 3929.5 4007.4 4011.3 4032.2 4036.3 3972.9 3991.7 3995.9 3996.7 3997.2 3988.3 4003.3 4005.9 4006.8 4013.0 3541.0 3557.8 3560.8 3564.1 3578.6 4854.9 4976.3 5014.6 5022.3 5050.4 4562.3 4580.8 4583.4 4595.7 4632.1 5364.5 5390.2 5405.5 5406.0 5407.3 3794.8 3827.2 3832.4 3851.6 3876.5 5547.0 5572.9 5603.8 5618.6 5633.9 3953.4 3957.7 3963.7 3964.1 3968.5 3862.4 4014.5 4018.4 4025.9 4057.1 4495.0 4502.1 4506.8 4518.4 4586.4 5270.9 5298.4 5326.7 5348.9 5354.8 1273.3 1363.8 1386.2 1389.4 1398.9 932.5 951.1 957.2 964.5 965.1 4589.2 4591.3 4595.8 4609.8 4621.0 5383.8 5410.5 5443.3 5493.9 5498.9 4442.0 4587.2 4638.7 4653.5 4654.7 2909.3 2941.5 2948.7 2958.3 2968.5 5226.2 5253.4 5258.3 5262.1 5284.8 5359.0 5713.7 5718.2 5728.6 5762.3 5239.5 5244.3 5244.7 5255.3 5289.6 5543.0 5546.3 5587.5 5600.3 5621.9 5210.5 5492.4 5496.1 5496.5 5507.0 5230.5 5245.7 5252.1 5259.9 5277.8 3820.7 3893.5 3926.3 3932.8 3933.5 5232.7 5386.2 5575.5 5586.7 5586.8 5385.8 5398.3 5409.9 5421.9 5422.6 5438.0 5445.0 5446.8 5447.6 5453.1 5063.9 5291.4 5291.7 5305.0 5326.4 5361.5 5373.6 5382.9 5411.5 5439.5 5224.8 5265.0 5276.0 5283.8 5291.1 02:00:46 INFO - PROCESS | 8024 | 02:00:46 INFO - PROCESS | 8024 | [#5] yui.html Cycles:180 Average:16759.42 Median:6956.46 stddev:25211.25 (362.4%) stddev-sans-first:25252.72 02:00:46 INFO - PROCESS | 8024 | Values: 583.4 584.0 604.2 625.4 658.3 12770.2 13450.0 13463.7 13492.9 13500.7 12150.3 12348.6 12565.4 13030.5 13088.3 760.7 779.0 779.1 784.1 787.1 792.5 792.8 793.7 793.8 795.6 830.2 831.7 832.9 834.6 836.3 820.1 822.7 823.4 824.9 827.0 602.6 603.2 607.5 610.7 611.0 11044.4 11082.5 11160.7 11177.7 11188.4 10817.5 10868.2 11021.8 11046.0 11276.5 8935.7 9178.0 9199.5 9301.9 9306.3 3251.5 3269.2 3314.2 3317.7 3378.7 57625.1 58256.0 58653.0 59334.0 61079.7 8265.9 8345.2 8373.5 8551.3 8568.7 16405.2 16462.3 16471.3 16488.4 16615.0 6196.8 6489.8 6835.8 6935.3 6977.7 3527.0 3621.0 3725.9 3742.2 3825.6 2722.4 2823.9 2835.4 2837.4 2849.0 494.0 502.9 504.7 511.9 513.3 497.6 523.0 562.3 565.4 585.7 7165.6 7232.3 7255.5 7414.7 7471.9 524.9 526.4 537.2 538.0 564.7 3532.6 3542.4 3594.6 3643.8 3710.9 89312.6 93162.5 95711.5 96022.0 96344.0 81105.0 85461.6 85648.0 85840.6 85977.6 73379.6 74455.3 74788.6 75556.0 76038.0 6871.9 6886.9 6992.5 7194.1 7218.8 43849.6 43910.3 44432.8 45565.0 45799.5 62822.4 63236.8 63343.4 63367.0 63437.4 8933.9 8941.1 8952.5 9225.8 9232.7 9475.5 9626.7 9672.0 9900.0 9938.6 8196.6 8307.5 8322.8 8365.5 8400.5 8087.8 8248.4 8294.2 8409.2 8757.0 8510.4 8938.1 9019.5 9036.5 9069.1 7721.8 7733.0 7862.1 7862.9 7896.2 7404.9 7711.7 7835.9 7909.1 7979.9 02:00:46 INFO - PROCESS | 8024 | -------- Summary: end -------- 02:00:46 INFO - PROCESS | 8024 | 02:00:47 INFO - TEST-INFO | 8024: exit 0 02:00:47 INFO - TEST-OK | dromaeo_css | took 1116161ms 02:00:47 INFO - TEST-START | kraken 02:00:47 INFO - operating with platform_type : linux_ 02:00:47 INFO - Initialising browser for kraken test... 02:00:47 INFO - TEST-INFO | started process 8269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm9TN28/profile http://localhost:39994/getInfo.html) 02:00:52 INFO - PROCESS | 8269 | __metrics Screen width/height:1600/1200 02:00:52 INFO - PROCESS | 8269 | colorDepth:24 02:00:52 INFO - PROCESS | 8269 | Browser inner width/height: 1024/697 02:00:52 INFO - PROCESS | 8269 | __metrics 02:00:53 ERROR - PROCESS | 8269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:00:54 INFO - TEST-INFO | 8269: exit 0 02:00:54 INFO - Browser initialized. 02:00:54 INFO - Running cycle 1/1 for kraken test... 02:00:54 INFO - TEST-INFO | started process 8390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm9TN28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:06 INFO - PROCESS | 8390 | RSS: Main: 169156608 02:01:06 INFO - PROCESS | 8390 | 02:01:09 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39994/tests/kraken/driver.html?testName=audio-beat-detection) 02:01:10 INFO - PROCESS | 8390 | RSS: Main: 173920256 02:01:10 INFO - PROCESS | 8390 | 02:01:12 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39994/tests/kraken/driver.html?testName=audio-dft) 02:01:13 INFO - PROCESS | 8390 | RSS: Main: 173518848 02:01:13 INFO - PROCESS | 8390 | 02:01:16 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39994/tests/kraken/driver.html?testName=audio-fft) 02:01:17 INFO - PROCESS | 8390 | RSS: Main: 168460288 02:01:17 INFO - PROCESS | 8390 | 02:01:19 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39994/tests/kraken/driver.html?testName=audio-oscillator) 02:01:19 INFO - PROCESS | 8390 | RSS: Main: 169484288 02:01:19 INFO - PROCESS | 8390 | 02:01:22 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39994/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:01:22 INFO - PROCESS | 8390 | RSS: Main: 169504768 02:01:22 INFO - PROCESS | 8390 | 02:01:25 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39994/tests/kraken/driver.html?testName=imaging-darkroom) 02:01:26 INFO - PROCESS | 8390 | RSS: Main: 169230336 02:01:26 INFO - PROCESS | 8390 | 02:01:29 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39994/tests/kraken/driver.html?testName=imaging-desaturate) 02:01:30 INFO - PROCESS | 8390 | RSS: Main: 167481344 02:01:30 INFO - PROCESS | 8390 | 02:01:33 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39994/tests/kraken/driver.html?testName=json-parse-financial) 02:01:34 INFO - PROCESS | 8390 | RSS: Main: 169189376 02:01:34 INFO - PROCESS | 8390 | 02:01:35 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39994/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:01:36 INFO - PROCESS | 8390 | RSS: Main: 169136128 02:01:36 INFO - PROCESS | 8390 | 02:01:38 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:01:39 INFO - PROCESS | 8390 | RSS: Main: 169611264 02:01:39 INFO - PROCESS | 8390 | 02:01:41 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:01:42 INFO - PROCESS | 8390 | RSS: Main: 169459712 02:01:42 INFO - PROCESS | 8390 | 02:01:44 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:45 INFO - PROCESS | 8390 | RSS: Main: 170119168 02:01:45 INFO - PROCESS | 8390 | 02:01:48 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:49 INFO - PROCESS | 8390 | RSS: Main: 169865216 02:01:49 INFO - PROCESS | 8390 | 02:01:50 INFO - PROCESS | 8390 | Cycle 1(1): loaded http://localhost:39994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39994/tests/kraken/driver.html?testName=ai-astar) 02:01:51 INFO - PROCESS | 8390 | RSS: Main: 170430464 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | __start_tp_report 02:01:51 INFO - PROCESS | 8390 | _x_x_mozilla_page_load 02:01:51 INFO - PROCESS | 8390 | _x_x_mozilla_page_load_details 02:01:51 INFO - PROCESS | 8390 | |i|pagename|runs| 02:01:51 INFO - PROCESS | 8390 | |0;ai-astar;107;117;109;114;116;116;117;114;117;116 02:01:51 INFO - PROCESS | 8390 | |1;audio-beat-detection;150;124;148;192;124;159;151;126;180;124 02:01:51 INFO - PROCESS | 8390 | |2;audio-dft;162;163;162;176;162;163;162;163;163;161 02:01:51 INFO - PROCESS | 8390 | |3;audio-fft;77;79;76;154;80;75;76;75;159;78 02:01:51 INFO - PROCESS | 8390 | |4;audio-oscillator;85;85;141;86;85;85;138;86;86;137 02:01:51 INFO - PROCESS | 8390 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;118;118;118 02:01:51 INFO - PROCESS | 8390 | |6;imaging-darkroom;147;149;148;147;147;148;147;148;148;148 02:01:51 INFO - PROCESS | 8390 | |7;imaging-desaturate;96;96;96;96;96;97;96;97;95;95 02:01:51 INFO - PROCESS | 8390 | |8;json-parse-financial;64;64;66;64;65;64;72;63;65;63 02:01:51 INFO - PROCESS | 8390 | |9;json-stringify-tinderbox;67;66;67;65;66;66;65;66;67;67 02:01:51 INFO - PROCESS | 8390 | |10;stanford-crypto-aes;83;85;79;81;81;80;81;80;81;80 02:01:51 INFO - PROCESS | 8390 | |11;stanford-crypto-ccm;138;146;145;141;133;139;129;135;177;142 02:01:51 INFO - PROCESS | 8390 | |12;stanford-crypto-pbkdf2;190;168;166;167;164;168;170;164;168;166 02:01:51 INFO - PROCESS | 8390 | |13;stanford-crypto-sha256-iterative;66;69;68;68;66;68;68;66;70;67 02:01:51 INFO - PROCESS | 8390 | __end_tp_report 02:01:51 INFO - PROCESS | 8390 | __start_cc_report 02:01:51 INFO - PROCESS | 8390 | _x_x_mozilla_cycle_collect,1003 02:01:51 INFO - PROCESS | 8390 | __end_cc_report 02:01:51 INFO - PROCESS | 8390 | __startTimestamp1468746111129__endTimestamp 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | ------- Summary: start ------- 02:01:51 INFO - PROCESS | 8390 | Number of tests: 14 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.00 stddev:3.53 (3.0%) stddev-sans-first:2.57 02:01:51 INFO - PROCESS | 8390 | Values: 107.0 117.0 109.0 114.0 116.0 116.0 117.0 114.0 117.0 116.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:150.50 stddev:24.28 (16.1%) stddev-sans-first:25.74 02:01:51 INFO - PROCESS | 8390 | Values: 150.0 124.0 148.0 192.0 124.0 159.0 151.0 126.0 180.0 124.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:4.37 (2.7%) stddev-sans-first:4.59 02:01:51 INFO - PROCESS | 8390 | Values: 162.0 163.0 162.0 176.0 162.0 163.0 162.0 163.0 163.0 161.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.50 stddev:33.58 (43.9%) stddev-sans-first:35.12 02:01:51 INFO - PROCESS | 8390 | Values: 77.0 79.0 76.0 154.0 80.0 75.0 76.0 75.0 159.0 78.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:85.00 stddev:25.74 (30.3%) stddev-sans-first:26.61 02:01:51 INFO - PROCESS | 8390 | Values: 85.0 85.0 141.0 86.0 85.0 85.0 138.0 86.0 86.0 137.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:01:51 INFO - PROCESS | 8390 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:01:51 INFO - PROCESS | 8390 | Values: 147.0 149.0 148.0 147.0 147.0 148.0 147.0 148.0 148.0 148.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:01:51 INFO - PROCESS | 8390 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 95.0 95.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.50 stddev:2.62 (4.1%) stddev-sans-first:2.76 02:01:51 INFO - PROCESS | 8390 | Values: 64.0 64.0 66.0 64.0 65.0 64.0 72.0 63.0 65.0 63.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 02:01:51 INFO - PROCESS | 8390 | Values: 67.0 66.0 67.0 65.0 66.0 66.0 65.0 66.0 67.0 67.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:1.73 (2.1%) stddev-sans-first:1.69 02:01:51 INFO - PROCESS | 8390 | Values: 83.0 85.0 79.0 81.0 81.0 80.0 81.0 80.0 81.0 80.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:141.50 stddev:13.22 (9.3%) stddev-sans-first:13.92 02:01:51 INFO - PROCESS | 8390 | Values: 138.0 146.0 145.0 141.0 133.0 139.0 129.0 135.0 177.0 142.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:168.00 stddev:7.58 (4.5%) stddev-sans-first:1.99 02:01:51 INFO - PROCESS | 8390 | Values: 190.0 168.0 166.0 167.0 164.0 168.0 170.0 164.0 168.0 166.0 02:01:51 INFO - PROCESS | 8390 | 02:01:51 INFO - PROCESS | 8390 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.30 02:01:51 INFO - PROCESS | 8390 | Values: 66.0 69.0 68.0 68.0 66.0 68.0 68.0 66.0 70.0 67.0 02:01:51 INFO - PROCESS | 8390 | -------- Summary: end -------- 02:01:51 INFO - PROCESS | 8390 | 02:01:52 INFO - TEST-INFO | 8390: exit 0 02:01:52 INFO - TEST-OK | kraken | took 64536ms 02:01:52 INFO - SUITE-END | took 1180s 02:01:52 INFO - Completed test suite (00:19:40) 02:01:52 INFO - javascript benchmark 02:01:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6341.041719202394, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.218185635237, 2684.5436275833113, 2695.555233386491, 2720.768734657554, 2729.304027472995, 4826.710397376156, 4874.244492103725, 4920.729359885205, 4941.67879087859, 4951.455339912607, 4617.984043510422, 4686.039361930804, 4696.741679207642, 4908.97545512272, 4927.556519913207, 4273.358996150587, 4335.9566404335865, 4364.585364390377, 4406.383106365111, 4407.845725399612, 42.227655322365045, 4206.137741762931, 4307.719998200123, 4360.236958532244, 4429.667774916878, 4424.535423780505, 4427.889302767424, 4454.8886277842985, 4484.125595508877, 4497.100579884036, 4457.24226881431, 4461.42001539801, 4487.483939346984, 4504.234280172379, 4527.0, 4298.46269216348, 4329.220740266751, 4329.9567004329865, 4344.174606824693, 4450.777461126963, 4710.481846996828, 4729.929051064237, 4736.242201247818, 4737.099951009297, 4745.762711864393, 5012.799488020475, 5055.6713813602, 5077.289179514871, 5077.898442031175, 5125.641205115643, 5245.213218017289, 5250.159974404115, 5253.789848406059, 5262.447443018466, 5267.604929630293, 4854.7572621369145, 4949.381327334083, 4958.752062396902, 4959.553640172329, 4997.025580011936, 5265.183896496049, 5326.5206131447585, 5435.42927992563, 5438.972805136028, 5444.537214336826, 5135.97432012845, 5136.614753893473, 5145.9485405146215, 5149.124648809711, 5192.584593232532, 5201.687898726089, 5248.448912864094, 5250.7637156328055, 5251.868703282372, 5298.735063246822, 4990.525900039491, 5115.616328775282, 5125.820596279113, 5153.974230128825, 5195.220716892496, 5152.613553983466, 5154.840160963753, 5164.406093299319, 5172.663776854568, 5205.401378841406, 4436.733795972252, 4446.177457170434, 4461.776911154429, 4463.776811159429, 4508.45898492183, 3725.0, 3788.6021967692996, 3805.657490825839, 3832.693384529231, 3849.3840985442193, 4261.190373828963, 4406.2949928012, 4415.381846541487, 4424.446944131983, 4445.844395446144, 5148.791691631745, 5162.819301324435, 5181.81863634771, 5184.326037615086, 5228.08508511009, 4401.625861801719, 4423.889402764892, 4431.069475410135, 4464.553544645574, 4471.955280447154, 4665.4168228971375, 4673.509281525459, 4679.602233810164, 4684.297355396718, 4720.811167553328, 4844.346013288232, 4895.7062576245535, 4899.902001960012, 4927.802887884444, 4939.283803848493, 4981.875453113701, 5146.305248791366, 5223.947760522498, 5234.162533994542, 5238.109521381451, 4876.195427754381, 4903.95096049035, 4908.582770464551, 4911.950880491149, 4971.527704868032, 5127.077126117335, 5130.5639020682165, 5153.819616313411, 5162.432132465501, 5162.767675454538, 5190.68855868634, 5210.6613070150315, 5241.868953276198, 5276.973615132053, 5298.576113910801, 5071.340725705634, 5075.3402057732255, 5086.7710953007945, 5097.209932460474, 5138.152204886302, 4808.567228949271, 5042.09242336383, 5067.721275329893, 5070.746462676925, 5102.69383836971, 4889.462159162418, 4896.90206195867, 4932.506749325039, 4957.776900039579, 4998.2502624606595, 5087.3386459759995, 5090.847274581768, 5091.92362114576, 5113.233015047773, 5113.51421614946, 4811.975940120417, 4930.975345123252, 4955.306257123933, 4979.103761322996, 4981.4769449207315], "value": 4716.941315357834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4607511601072, 560.6972234993103, 575.0683892094808, 575.9164921086442, 581.2617975171535, 35512.0, 40082.398764018566, 40092.59907400929, 40182.397264041065, 40259.396109058354, 40540.0, 40978.7951060245, 41072.79463602678, 41175.38236926449, 41259.174816503655, 7620.352270057052, 7771.145174030852, 7786.805329866742, 7806.2193780621765, 7818.061832580099, 7717.2668596483245, 7788.299053085221, 7825.9608701956695, 7831.569263690495, 7844.450888437812, 7807.258310460497, 7866.292033716964, 7900.486468379566, 7910.0, 7910.4462687611895, 7787.415943804209, 7810.375169986388, 7814.023247094114, 7822.804429889241, 7840.882386764203, 7756.379489640815, 7790.259925307087, 7823.530588164728, 7827.804304892366, 7833.804154896173, 37730.245395091944, 38092.23815523702, 38211.80894095512, 38301.0, 38318.0, 2947.6168098147105, 3165.9525107123413, 3187.235063584746, 3192.537082123102, 3201.599800024997, 29137.56293655597, 29167.41665166685, 29312.413751724845, 29576.11271661832, 29923.401531969455, 3359.81521016344, 3384.9323013539592, 3396.5584474018465, 3399.456087026089, 3471.826408679581, 250861.0, 251038.0, 252328.0, 252384.73807631028, 252620.0, 31696.207594809854, 51585.2262216067, 51690.0, 51734.0, 51824.74087629538, 31742.0, 33738.49392259118, 33824.1543961398, 33903.0, 33924.1518962023, 13319.40062697181, 13416.262105584286, 13465.528706495226, 13491.0, 13491.460341586228, 11083.168762342857, 11121.0, 11194.0, 11206.719832004102, 11258.0, 7880.921190788134, 7897.960510197528, 7917.564533950688, 7941.444098913021, 7955.323797477164, 2979.6722360540325, 3136.81179129253, 3146.921326966844, 3169.793963392372, 3170.936581268362, 900.4372267332917, 916.9724908252763, 939.6006697153682, 945.645382981382, 1034.7568321444455, 27875.860620696767, 28172.0, 28824.279393015342, 29128.708712913023, 29222.269443263664, 918.3112665500875, 948.1656142594472, 972.7470857577081, 1023.5752162852482, 1027.5632856036304, 14354.712905741826, 14547.854521454861, 14619.853801462063, 14810.185439800915, 14838.851611483748, 394232.0, 394796.0, 398468.0, 399180.0, 401968.0, 48536.0, 49028.26457603139, 49172.0, 49186.26220606694, 49410.0, 1133.8752737198902, 1160.2690305107897, 1167.177140116216, 1180.474688763492, 1183.0771997841525, 25676.229713108638, 27177.86411068011, 27494.587581186697, 27578.724212758418, 28401.28996775097, 42961.78519107385, 47196.820079496916, 47535.0, 47542.0, 47573.0, 366801.0, 369910.0, 371395.0, 372456.0, 374162.0, 37862.24275514529, 38057.80971095127, 38604.613953861226, 38707.0, 39424.40863387109, 42628.36057459203, 43057.70826875199, 43362.349564755925, 43435.782821086956, 44057.0, 34235.315293693486, 36988.0, 37002.44496332611, 37112.0, 37294.81352593219, 36690.44964325484, 36746.448803268504, 36845.81577092098, 37085.62914370822, 37630.81184594169, 32873.83563082265, 35464.822675886455, 37943.81028094842, 38667.80666096652, 38781.0, 31874.043778686675, 32427.0, 32794.50808237831, 32917.50623740598, 33024.66975330216, 25494.490110197323, 25645.61531577065, 25704.742952570236, 26015.609765853147, 26062.218133456026], "value": 16831.802166807473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.52700543304564, 377.45457813459547, 378.6005763919065, 387.6317498376543, 389.92006638639083, 16247.268872900719, 16987.57531061724, 18043.00763458011, 18044.458666240032, 18537.443876683687, 10920.617778377758, 11271.436428178578, 11485.368304743235, 11542.769144617103, 11593.130515211371, 4266.317389217726, 4754.524547545244, 4917.7541122943885, 4923.483034281403, 4926.11329960607, 4771.212749896263, 4814.590759785422, 4821.228603423453, 4825.155597770394, 4826.0830442215865, 4786.066716990188, 4807.61539076873, 4810.11012962603, 4856.125897338496, 4858.4898585648525, 4822.035592881438, 4826.927596086061, 4852.660313778037, 4855.878603034935, 4864.708117512942, 4527.366168736379, 4618.953810461886, 4719.834805781781, 4748.691335063209, 4774.880627984294, 12801.0, 12866.228026318451, 12873.806892896613, 12955.5465558705, 18325.816741832543, 2015.475976246172, 2022.4943764058985, 2048.6414877396396, 2416.395901024744, 2446.608542633188, 9585.808283834354, 9643.324967252294, 12543.498260069586, 13290.933545332307, 13356.332183390792, 1730.4722059771764, 1775.7513948047153, 1781.340903865578, 1797.1822820616587, 1814.3921786201638, 71364.2863571368, 71693.64153179253, 72105.27894721038, 74410.0, 74787.0, 10126.594936202617, 10129.088382045504, 10260.0, 10342.172626189888, 10527.894721052691, 14116.153030817979, 14136.15183089018, 14181.85818141826, 14280.50018249377, 14289.356978935974, 7233.683242816525, 7400.5189662671755, 7460.776176714708, 7535.660895259726, 7542.811429714301, 6699.263081061079, 6700.430463410567, 6931.1682598088555, 6999.09011828459, 7171.641417929082, 4390.165868484977, 4407.096545208289, 4413.646908247332, 4422.358757980075, 4462.9107417851465, 1813.963720725578, 1826.8538516918616, 1848.491664792166, 1861.9069046547888, 1899.335232668555, 804.7947773317767, 892.7991201979632, 898.6405437824923, 908.3051465628799, 932.6316105138568, 17057.0, 17517.40081658579, 17755.911220443813, 17757.556061098578, 17926.462206133838, 797.1510341486298, 826.5412695953803, 856.1866227084171, 890.844102282098, 898.7483504618717, 9741.464219467998, 9744.707658770249, 9810.852837207447, 9872.40765554069, 9872.703818885446, 366054.0, 366954.0, 387711.0, 390705.0, 395323.0, 80949.0, 82440.0, 82457.17542824495, 83030.58484707538, 83803.0, 913.3515204205089, 914.7255823252998, 918.169057003413, 919.3748251189255, 928.679605536089, 15255.771163432779, 15350.539483815057, 15516.22418879029, 15669.138197399252, 15875.206239688201, 35760.821195893855, 36670.8166459166, 37440.438393423574, 37483.81258093692, 37811.81094094622, 49730.0, 52180.0, 52331.0, 52524.73737631287, 52803.471965281395, 7495.43784216175, 7928.08826984881, 7946.8807967881685, 7996.880046799419, 8059.032916050111, 8968.192862642394, 11346.659600212008, 11904.761904761683, 11929.03170976779, 12448.813267801172, 9874.654387096418, 9912.0, 10652.254342195973, 10711.464426778473, 10914.50884710174, 10012.0, 10183.541740621542, 10221.386716797017, 10229.74425639365, 10304.278700490893, 9879.259055571005, 10025.699229023141, 10043.949780251052, 10323.896761032294, 11006.724831879266, 7702.191269916578, 7721.498102623312, 7780.221977802401, 7857.017872765904, 7996.32031277348, 8753.34349923771, 9826.508674566387, 10265.58937642486, 10445.425501597485, 10685.893141068489], "value": 8080.446719657884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.855430179831, 1419.3612874206606, 1505.330128092999, 1695.524534180097, 1706.6757316109945, 6586.769463068794, 7507.812304692378, 7517.812054698636, 8031.237032481912, 8069.112397636262, 7853.528788272693, 8078.232567906054, 8140.1452847451055, 8154.836903261946, 8160.6327715252955, 2202.031106313217, 2245.393743689203, 2245.9438514037115, 2249.167807911067, 2255.0979608156786, 2219.766924472923, 2239.5632851593946, 2242.6187548116777, 2244.8091912187483, 2245.14684419921, 2176.9891150544227, 2183.4977955070344, 2198.263581700124, 2202.482416632098, 2202.8237740980685, 2151.848760912912, 2161.297578287063, 2170.8806015669134, 2179.2917301876955, 2183.7816218378193, 2169.39257008038, 2178.3247193370107, 2180.7056047433553, 2182.6835108909277, 2193.2981445937307, 7972.880406793903, 7981.1220765715725, 7994.360451163893, 7995.360371170293, 8028.4781489203015, 4542.205114105019, 4635.930461043087, 4689.038747056845, 4689.366935463703, 4696.3894693689945, 2721.0, 2754.5317296059716, 2765.363966287745, 2790.1071657069747, 2797.2727090956496, 847.4788005376711, 869.4522450855984, 882.4661080046544, 895.3061377432476, 896.7758060484879, 10646.0, 10717.464126793708, 10749.731256718567, 10753.085987691056, 10775.784484310348, 4050.1292222171787, 4258.893527661771, 4258.914821703549, 4324.978375108104, 4339.1972485090355, 9091.454512729257, 9110.863337049817, 9135.177833994972, 9137.543122843832, 9173.816523669622, 4680.391549098664, 4686.226772582554, 4699.271612900006, 4710.152172608963, 4737.0, 3589.533360663097, 4262.50981137167, 4324.56754324565, 4334.869953901388, 4416.492103408085, 3602.9819850900576, 3693.5567731872347, 3709.4992176056426, 3737.794421306854, 3762.9059273518383, 1225.209739717877, 1229.8093795461718, 1231.612042206702, 1233.8827811357908, 1237.7153254751458, 671.5366397185926, 726.6512074204411, 808.9878651820227, 831.9974430810859, 832.825106727594, 5104.285400043997, 5178.6116041297055, 5452.945470545244, 5585.357683866408, 5857.384974577608, 857.8884744983112, 869.3740506835069, 885.9867101993475, 891.7101941868789, 896.3277541843618, 3216.388886111678, 3562.4478205877613, 3565.16218688608, 3574.9285014299567, 3588.3720348939355, 9687.128158465772, 10077.193824494023, 10193.388396696222, 10211.234157438073, 10221.540030698636, 9989.60041598328, 10108.646197383056, 10118.949405253074, 10126.746831329276, 10134.037266459674, 7144.463940252871, 7241.348278654947, 7449.962750186322, 7457.701691932262, 7654.7320843769085, 5418.403975562606, 5428.83713488596, 5520.861978450571, 5558.055130627884, 5668.1214411764595, 8659.090795466638, 8788.692395766118, 8822.426542274732, 8873.467591944504, 9042.0, 8818.0, 8821.294296456397, 8883.955580222058, 8937.06160853101, 8981.191692747683, 5915.319738230159, 6562.868742625216, 6740.831479213059, 6902.827429314308, 7096.53872498286, 7856.607169641609, 7873.37013038967, 7928.08826984881, 7941.483803552751, 7959.403044771781, 6821.522493425413, 6927.307269273234, 7051.541649792747, 7216.278372162742, 7227.349538541556, 6858.862822743617, 6889.0, 7044.225135235018, 7056.506044577036, 7137.0, 6324.936750632435, 6342.23893132827, 6345.8730825384155, 6363.395477429637, 6401.519886008475, 4567.794449249725, 4574.794134264032, 4591.862244132682, 4609.492955774795, 4617.51516090819, 4538.29656403258, 4559.886002849956, 4593.586577208067, 4627.236505976476, 4661.743604101672], "value": 4186.103456592142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.84153319507243, 307.69691853524284, 313.0779853331937, 316.49993011042557, 316.54101552748523, 4963.404391473019, 4980.950190498094, 5085.626880742202, 5200.50595193457, 5226.738663066846, 4999.175136102548, 5010.849674509762, 5038.193888977764, 5038.571721403676, 5041.571466425349, 3978.76127432355, 3983.541892682342, 3991.820368083443, 3995.3407687731487, 4020.6582440492593, 3929.469521614574, 4007.438958545791, 4011.2980228460046, 4032.213718324928, 4036.3340048891896, 3972.9006774830714, 3991.680665546764, 3995.9200815983663, 3996.700247481436, 3997.2205419943125, 3988.3419235826054, 4003.2994226010624, 4005.859794907164, 4006.83972641094, 4012.9598704013024, 3540.982295088508, 3557.7547858249404, 3560.8041557714314, 3564.0733409313507, 3578.6063533011347, 4854.878628034292, 4976.328195693572, 5014.623903207274, 5022.321986531808, 5050.409121126833, 4562.338460923181, 4580.7938642761155, 4583.449986001668, 4595.655325850575, 4632.10493441599, 5364.497940576644, 5390.21841832932, 5405.5135037846385, 5405.972970135163, 5407.297051383295, 3794.753341032824, 3827.158025234444, 3832.42513622956, 3851.5763266040713, 3876.5348158220913, 5546.972265138689, 5572.888542229173, 5603.80386686464, 5618.634788738719, 5633.943660563383, 3953.4267531207815, 3957.742746721454, 3963.742356746802, 3964.147708242742, 3968.543617484026, 3862.4013277941963, 4014.518257809023, 4018.4374187613757, 4025.9194816103513, 4057.127717540684, 4495.0, 4502.144592527409, 4506.752128632957, 4518.4126063612175, 4586.449626044896, 5270.947290527046, 5298.443663415363, 5326.6537675050995, 5348.91976620351, 5354.812581559627, 1273.2678709741936, 1363.8363396392497, 1386.2237147197602, 1389.3817251323064, 1398.9440422383195, 932.5244125496046, 951.1344676344494, 957.1911734584265, 964.5418426247617, 965.1035714820412, 4589.196890544142, 4591.288350305641, 4595.839145629954, 4609.838655647036, 4620.953790462052, 5383.811566595229, 5410.48600382963, 5443.346798384219, 5493.862653433696, 5498.917516237259, 4441.977790111094, 4587.243104887723, 4638.744869032235, 4653.511381304914, 4654.720716757005, 2909.3163106669917, 2941.4558306713325, 2948.7051294870344, 2958.304798372381, 2968.539876319174, 5226.163813789775, 5253.4221235664045, 5258.290130832289, 5262.131748261494, 5284.81503147388, 5359.0, 5713.714314284269, 5718.199452076713, 5728.598998070179, 5762.2509073820975, 5239.528442440199, 5244.325394049062, 5244.6853188809555, 5255.343082114736, 5289.57683385336, 5543.0, 5546.251256080377, 5587.469190426903, 5600.299962504687, 5621.943780562142, 5210.452902445189, 5492.423295553909, 5496.148097044965, 5496.532794712334, 5506.971165858842, 5230.503102205284, 5245.737713114406, 5252.111338763589, 5259.894802104013, 5277.762500687555, 3820.6752426042985, 3893.4743809585343, 3926.2540117377607, 3932.842686292516, 3933.4886464759397, 5232.68603883753, 5386.245925570345, 5575.498205161392, 5586.720663966704, 5586.776528938797, 5385.838424847261, 5398.2982212312145, 5409.918851217156, 5421.864453388697, 5422.62041657096, 5437.972810135924, 5445.0, 5446.754896029609, 5447.564194864481, 5453.072977593898, 5063.898722025612, 5291.391489978548, 5291.735413229246, 5305.0, 5326.41409444953, 5361.490658387447, 5373.596980226577, 5382.892342153056, 5411.485908838654, 5439.5104440600535, 5224.843254702365, 5265.0, 5276.0214919405225, 5283.788648454172, 5291.126964051043], "value": 4052.645729783047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4224118123058, 583.9795607153748, 604.1964187630449, 625.3996163682864, 658.3350815676166, 12770.169938953974, 13450.0, 13463.663408414783, 13492.865071349308, 13500.729985400287, 12150.331731754772, 12348.629541113782, 12565.37173141344, 13030.478780848778, 13088.345582720873, 760.7033257029763, 778.9922100779005, 779.123486078162, 784.1413652050995, 787.1498781316193, 792.5442870349543, 792.7859477940953, 793.738066438074, 793.8015496125969, 795.5942469340649, 830.1822704635929, 831.6881169561415, 832.9042160151599, 834.6285902773268, 836.3016880904452, 820.0856045509244, 822.6873787960596, 823.390690888744, 824.9216324449168, 826.9917300826975, 602.6143268308242, 603.2399177036965, 607.4684650930436, 610.6885488400948, 610.9725062372204, 11044.447777611087, 11082.501287442085, 11160.720981975435, 11177.66467005991, 11188.38463884486, 10817.459127043616, 10868.239223254375, 11021.83467247992, 11046.0, 11276.492557834836, 8935.719506919346, 9178.0, 9199.494027828467, 9301.90698093024, 9306.348555601111, 3251.4797632378704, 3269.1500209945348, 3314.2211580278617, 3317.701406873393, 3378.729701623864, 57625.13562296527, 58256.0, 58653.0, 59334.0, 61079.69460152715, 8265.917340826634, 8345.248927596545, 8373.539455330016, 8551.315894728406, 8568.657253709782, 16405.1797410129, 16462.341506339853, 16471.25879335433, 16488.422905198502, 16615.0, 6196.783112591038, 6489.772857949949, 6835.829104272433, 6935.271796461399, 6977.651117444209, 3526.964730352715, 3620.981895090508, 3725.906852328659, 3742.214135031619, 3825.5600605930117, 2722.4146808435885, 2823.9011634593103, 2835.376217232206, 2837.446697893932, 2848.9715102848704, 494.0, 502.88936433984463, 504.68961588622733, 511.88482591416636, 513.3301042140043, 497.6317525031523, 522.9633925625246, 562.2746656812666, 565.366789196103, 585.6661702829432, 7165.570065796069, 7232.276772322725, 7255.492115551966, 7414.666340014713, 7471.850562988819, 524.9317588713519, 526.3867594252729, 537.2022546518417, 537.9596530260246, 564.7232855900579, 3532.6290739472497, 3542.4155014422845, 3594.6405359463843, 3643.7813731176216, 3710.925781484409, 89312.5534372324, 93162.53418732862, 95711.52144239235, 96022.0, 96344.0, 81105.0, 85461.57269213613, 85648.0, 85840.57079714561, 85977.5701121503, 73379.63310183414, 74455.25544744592, 74788.62605686937, 75556.0, 76038.0, 6871.9312806873295, 6886.8622627546165, 6992.510524263253, 7194.100737407824, 7218.783436496913, 43849.56150438455, 43910.34134488049, 44432.777836111905, 45565.0, 45799.542004580864, 62822.37177628165, 63236.83815809283, 63343.36656633559, 63367.0, 63437.36562634315, 8933.910660893307, 8941.061188575106, 8952.462852228888, 9225.815483690423, 9232.723018309462, 9475.526223688927, 9626.66306679263, 9671.951640242036, 9899.95050024774, 9938.602455901682, 8196.631151598072, 8307.501549907025, 8322.750317490485, 8365.456245344034, 8400.453970492143, 8087.83824323522, 8248.422610417214, 8294.212049855254, 8409.2431681149, 8757.036725960012, 8510.404271700922, 8938.061503542034, 9019.458832470073, 9036.548172591476, 9069.093090690878, 7721.7683469496005, 7732.961335193288, 7862.135165131716, 7862.861224368331, 7896.210378962058, 7404.888926665996, 7711.6915323388685, 7835.882461762964, 7909.129995700353, 7979.880301795594], "value": 5972.337000476489, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 109.0, 114.0, 116.0, 116.0, 117.0, 114.0, 117.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 148.0, 192.0, 124.0, 159.0, 151.0, 126.0, 180.0, 124.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 176.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 76.0, 154.0, 80.0, 75.0, 76.0, 75.0, 159.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 141.0, 86.0, 85.0, 85.0, 138.0, 86.0, 86.0, 137.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 65.0, 64.0, 72.0, 63.0, 65.0, 63.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 79.0, 81.0, 81.0, 80.0, 81.0, 80.0, 81.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 146.0, 145.0, 141.0, 133.0, 139.0, 129.0, 135.0, 177.0, 142.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 168.0, 166.0, 167.0, 164.0, 168.0, 170.0, 164.0, 168.0, 166.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 68.0, 66.0, 68.0, 68.0, 66.0, 70.0, 67.0], "value": 67.6, "unit": "score"}]}]} 02:01:52 INFO - Return code: 0 02:01:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:01:52 ERROR - # TBPL SUCCESS # 02:01:52 INFO - Running post-action listener: _resource_record_post_action 02:01:52 INFO - ##### 02:01:52 INFO - ##### Finished run-tests step (success) 02:01:52 INFO - ##### 02:01:52 INFO - Running post-run listener: _resource_record_post_run 02:01:52 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536911872; Read time: 8; Write time: 659876 02:01:52 INFO - TinderboxPrint: CPU usage
13.3% 02:01:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:01:52 INFO - TinderboxPrint: I/O write bytes / time
536,911,872 / 659,876 02:01:52 INFO - TinderboxPrint: CPU idle
8,279.4 (86.7%) 02:01:52 INFO - TinderboxPrint: CPU user
1,217.8 (12.7%) 02:01:52 INFO - TinderboxPrint: Swap in / out
0 / 0 02:01:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246288384; Read time: 0; Write time: 322944 02:01:52 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290349056; Read time: 8; Write time: 336904 02:01:53 INFO - Running post-run listener: _upload_blobber_files 02:01:53 INFO - Blob upload gear active. 02:01:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:01:53 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 02:01:53 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:01:53 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:01:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:54 INFO - (blobuploader) - INFO - Done attempting. 02:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:58 INFO - (blobuploader) - INFO - Done attempting. 02:01:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:01:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:01:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:01:59 INFO - (blobuploader) - INFO - Done attempting. 02:01:59 INFO - (blobuploader) - INFO - Iteration through files over. 02:01:59 INFO - Return code: 0 02:01:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:01:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:01:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e6ae202ace75bef6aafdb9455e92b9a0ee4a3a48f427eff2a6af523cb815643326e7be88f03b33d1af084821f08bcedd43d1dba2707da73d2150d5972ac70fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2859db5f0227a2160843b070ca9b95d94baf72898f29fa806aa6af357ffaa0c83032d2e64330a914066ecd55d423acb2b45578bf35113c588baab7f3624f164f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19f2cbae4601329edccd54307833774e72536f6eeba1cd92bf8bc4830c96aa1e414f1c168210c1297699d376a5d8dfcf8ca200aab2aac41fdf475c3622b13432"} 02:01:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:01:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:01:59 INFO - Contents: 02:01:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e6ae202ace75bef6aafdb9455e92b9a0ee4a3a48f427eff2a6af523cb815643326e7be88f03b33d1af084821f08bcedd43d1dba2707da73d2150d5972ac70fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2859db5f0227a2160843b070ca9b95d94baf72898f29fa806aa6af357ffaa0c83032d2e64330a914066ecd55d423acb2b45578bf35113c588baab7f3624f164f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19f2cbae4601329edccd54307833774e72536f6eeba1cd92bf8bc4830c96aa1e414f1c168210c1297699d376a5d8dfcf8ca200aab2aac41fdf475c3622b13432"} 02:01:59 INFO - Running post-run listener: copy_logs_to_upload_dir 02:01:59 INFO - Copying logs to upload dir... 02:01:59 INFO - mkdir: /builds/slave/test/build/upload/logs 02:01:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.894485 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-17 02:01:58.055083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:01:58.058733) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 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/Firefox-Non-PGO/sha512/1e6ae202ace75bef6aafdb9455e92b9a0ee4a3a48f427eff2a6af523cb815643326e7be88f03b33d1af084821f08bcedd43d1dba2707da73d2150d5972ac70fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2859db5f0227a2160843b070ca9b95d94baf72898f29fa806aa6af357ffaa0c83032d2e64330a914066ecd55d423acb2b45578bf35113c588baab7f3624f164f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19f2cbae4601329edccd54307833774e72536f6eeba1cd92bf8bc4830c96aa1e414f1c168210c1297699d376a5d8dfcf8ca200aab2aac41fdf475c3622b13432"} build_url:https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/OcVEwSlYQSGlCQ_ZsSS31Q/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/Firefox-Non-PGO/sha512/1e6ae202ace75bef6aafdb9455e92b9a0ee4a3a48f427eff2a6af523cb815643326e7be88f03b33d1af084821f08bcedd43d1dba2707da73d2150d5972ac70fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2859db5f0227a2160843b070ca9b95d94baf72898f29fa806aa6af357ffaa0c83032d2e64330a914066ecd55d423acb2b45578bf35113c588baab7f3624f164f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19f2cbae4601329edccd54307833774e72536f6eeba1cd92bf8bc4830c96aa1e414f1c168210c1297699d376a5d8dfcf8ca200aab2aac41fdf475c3622b13432"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:01:58.084189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:01:58.084526) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468744787.970649-434899172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:01:58.168267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:01:58.168635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:01:58.168963) ========= ========= Total master_lag: 0.16 =========