builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1468593370.82 results: success (0) buildid: 20160713163005 builduid: 4e27467b6b114389b436cd7afdc62c4a revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.825075) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.825487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.825804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.913832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.914207) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 07:36:10-- 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% 222M=0s 2016-07-15 07:36:11 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.050536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.050856) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.102550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.102926) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 07:36:11,166 truncating revision to first 12 chars 2016-07-15 07:36:11,166 Setting DEBUG logging. 2016-07-15 07:36:11,166 attempt 1/10 2016-07-15 07:36:11,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 07:36:11,475 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.755209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.755523) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.755963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.756274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.766234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-07-15 07:36:11.766638) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:11 INFO - MultiFileLogger online at 20160715 07:36:11 in /builds/slave/test 07:36:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:11 INFO - {'append_to_log': False, 07:36:11 INFO - 'base_work_dir': '/builds/slave/test', 07:36:11 INFO - 'blob_upload_branch': 'Firefox', 07:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:11 INFO - 'branch': 'Firefox', 07:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:11 INFO - 'config_files': ('talos/linux_config.py',), 07:36:11 INFO - 'default_actions': ('clobber', 07:36:11 INFO - 'read-buildbot-config', 07:36:11 INFO - 'download-and-extract', 07:36:11 INFO - 'populate-webroot', 07:36:11 INFO - 'create-virtualenv', 07:36:11 INFO - 'install', 07:36:11 INFO - 'run-tests'), 07:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:11 INFO - 'download_minidump_stackwalk': True, 07:36:11 INFO - 'download_symbols': 'ondemand', 07:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:11 INFO - 'installer_path': 'installer.exe', 07:36:11 INFO - 'log_level': 'info', 07:36:11 INFO - 'log_name': 'talos', 07:36:11 INFO - 'log_to_console': True, 07:36:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:11 INFO - 'opt_config_files': (), 07:36:11 INFO - 'pip_index': False, 07:36:11 INFO - 'sps_profile': False, 07:36:11 INFO - 'sps_profile_interval': 0, 07:36:11 INFO - 'suite': 'dromaeojs-e10s', 07:36:11 INFO - 'system_bits': '32', 07:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:11 INFO - 'title': 'talos-linux64-ix-069', 07:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:11 INFO - 'use_talos_json': True, 07:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:11 INFO - 'work_dir': 'build'} 07:36:11 INFO - ##### 07:36:11 INFO - ##### Running clobber step. 07:36:11 INFO - ##### 07:36:11 INFO - Running pre-action listener: _resource_record_pre_action 07:36:11 INFO - Running main action method: clobber 07:36:11 INFO - rmtree: /builds/slave/test/build 07:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - ##### 07:36:12 INFO - ##### Finished clobber step (success) 07:36:12 INFO - ##### 07:36:12 INFO - ##### 07:36:12 INFO - ##### Running read-buildbot-config step. 07:36:12 INFO - ##### 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: read_buildbot_config 07:36:12 INFO - Using buildbot properties: 07:36:12 INFO - { 07:36:12 INFO - "project": "", 07:36:12 INFO - "product": "firefox", 07:36:12 INFO - "script_repo_revision": "production", 07:36:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:36:12 INFO - "repository": "", 07:36:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:36:12 INFO - "buildid": "20160713163005", 07:36:12 INFO - "pgo_build": "True", 07:36:12 INFO - "basedir": "/builds/slave/test", 07:36:12 INFO - "buildnumber": 95, 07:36:12 INFO - "slavename": "talos-linux64-ix-069", 07:36:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:12 INFO - "platform": "ubuntu64_hw", 07:36:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:36:12 INFO - "branch": "mozilla-central", 07:36:12 INFO - "repo_path": "mozilla-central", 07:36:12 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 07:36:12 INFO - "stage_platform": "linux64-pgo", 07:36:12 INFO - "builduid": "4e27467b6b114389b436cd7afdc62c4a", 07:36:12 INFO - "slavebuilddir": "test" 07:36:12 INFO - } 07:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - ##### 07:36:12 INFO - ##### Finished read-buildbot-config step (success) 07:36:12 INFO - ##### 07:36:12 INFO - ##### 07:36:12 INFO - ##### Running download-and-extract step. 07:36:12 INFO - ##### 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: download_and_extract 07:36:12 INFO - mkdir: /builds/slave/test/build/tests 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:12 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:22 INFO - Downloaded 1361 bytes. 07:36:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:22 INFO - Using the following test package requirements: 07:36:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'jsshell-linux-x86_64.zip'], 07:36:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:22 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:25 INFO - Downloaded 24326108 bytes. 07:36:25 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'] 07:36:25 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 07:36:26 INFO - Return code: 0 07:36:26 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 07:36:26 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')]} 07:36:26 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:56 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:36:56 INFO - retry: attempt #1 caught exception: timed out 07:36:56 INFO - retry: Failed, sleeping 30 seconds before retrying 07:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 #2 07:37:27 INFO - Downloaded 24326108 bytes. 07:37:27 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'] 07:37:27 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 07:37:29 INFO - Return code: 0 07:37: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')]} 07:37:29 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:30 INFO - Downloaded 14403317 bytes. 07:37: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'] 07:37: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 07:37:30 INFO - Return code: 0 07:37: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')]} 07:37:30 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:31 INFO - Downloaded 60811395 bytes. 07:37:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:31 INFO - mkdir: /builds/slave/test/properties 07:37:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:31 INFO - Contents: 07:37:31 INFO - build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - Running post-action listener: set_extra_try_arguments 07:37:32 INFO - ##### 07:37:32 INFO - ##### Finished download-and-extract step (success) 07:37:32 INFO - ##### 07:37:32 INFO - ##### 07:37:32 INFO - ##### Running populate-webroot step. 07:37:32 INFO - ##### 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: populate_webroot 07:37:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:32 INFO - '--tppagecycles', 07:37:32 INFO - '7'], 07:37:32 INFO - 'tests': ['tsvgm']}}, 07:37:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o']}, 07:37:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['tp5o']}, 07:37:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s', 07:37:32 INFO - '--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}, 07:37:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}}, 07:37:32 INFO - 'talos.zip': {'path': '', 07:37:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - ##### 07:37:32 INFO - ##### Finished populate-webroot step (success) 07:37:32 INFO - ##### 07:37:32 INFO - ##### 07:37:32 INFO - ##### Running create-virtualenv step. 07:37:32 INFO - ##### 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: create_virtualenv 07:37:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:32 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 07:37:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:32 INFO - Using real prefix '/usr' 07:37:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:35 INFO - Installing pip.................done. 07:37:35 INFO - Return code: 0 07:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37: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 07:37: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 07:37:35 INFO - Using env: {'DISPLAY': ':0', 07:37:35 INFO - 'HOME': '/home/cltbld', 07:37:35 INFO - 'LANG': 'en_US.UTF-8', 07:37:35 INFO - 'LANGUAGE': 'en_US:en', 07:37:35 INFO - 'LOGNAME': 'cltbld', 07:37:35 INFO - 'MAIL': '/var/mail/cltbld', 07:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:35 INFO - 'MOZ_NO_REMOTE': '1', 07:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:35 INFO - 'NO_EM_RESTART': '1', 07:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:35 INFO - 'PWD': '/builds/slave/test', 07:37:35 INFO - 'SHELL': '/bin/bash', 07:37:35 INFO - 'SHLVL': '1', 07:37:35 INFO - 'TERM': 'linux', 07:37:35 INFO - 'TMOUT': '86400', 07:37:35 INFO - 'USER': 'cltbld', 07:37:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:35 INFO - '_': '/tools/buildbot/bin/python'} 07:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37: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 07:37:35 INFO - Cleaning up... 07:37:35 INFO - Return code: 0 07:37:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37: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 07:37: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 07:37:35 INFO - Using env: {'DISPLAY': ':0', 07:37:35 INFO - 'HOME': '/home/cltbld', 07:37:35 INFO - 'LANG': 'en_US.UTF-8', 07:37:35 INFO - 'LANGUAGE': 'en_US:en', 07:37:35 INFO - 'LOGNAME': 'cltbld', 07:37:35 INFO - 'MAIL': '/var/mail/cltbld', 07:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:35 INFO - 'MOZ_NO_REMOTE': '1', 07:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:35 INFO - 'NO_EM_RESTART': '1', 07:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:35 INFO - 'PWD': '/builds/slave/test', 07:37:35 INFO - 'SHELL': '/bin/bash', 07:37:35 INFO - 'SHLVL': '1', 07:37:35 INFO - 'TERM': 'linux', 07:37:35 INFO - 'TMOUT': '86400', 07:37:35 INFO - 'USER': 'cltbld', 07:37:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:35 INFO - '_': '/tools/buildbot/bin/python'} 07:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:35 INFO - Downloading/unpacking psutil>=3.1.1 07:37:35 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 07:37:35 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 07:37:35 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 07:37:35 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 07:37:35 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 07:37:35 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 07:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:37 INFO - Installing collected packages: psutil 07:37:37 INFO - Running setup.py install for psutil 07:37:37 INFO - building 'psutil._psutil_linux' extension 07:37:37 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 07:37: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 07:37:38 INFO - building 'psutil._psutil_posix' extension 07:37: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 07:37: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 07:37:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:38 INFO - Successfully installed psutil 07:37:38 INFO - Cleaning up... 07:37:39 INFO - Return code: 0 07:37:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:39 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')]} 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:39 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')]} 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:39 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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37:39 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 07:37:39 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 07:37:39 INFO - Using env: {'DISPLAY': ':0', 07:37:39 INFO - 'HOME': '/home/cltbld', 07:37:39 INFO - 'LANG': 'en_US.UTF-8', 07:37:39 INFO - 'LANGUAGE': 'en_US:en', 07:37:39 INFO - 'LOGNAME': 'cltbld', 07:37:39 INFO - 'MAIL': '/var/mail/cltbld', 07:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:39 INFO - 'MOZ_NO_REMOTE': '1', 07:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:39 INFO - 'NO_EM_RESTART': '1', 07:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:39 INFO - 'PWD': '/builds/slave/test', 07:37:39 INFO - 'SHELL': '/bin/bash', 07:37:39 INFO - 'SHLVL': '1', 07:37:39 INFO - 'TERM': 'linux', 07:37:39 INFO - 'TMOUT': '86400', 07:37:39 INFO - 'USER': 'cltbld', 07:37:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:39 INFO - '_': '/tools/buildbot/bin/python'} 07:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:39 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 07:37:39 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 07:37:39 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 07:37:39 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 07:37:39 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 07:37:39 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 07:37:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:41 INFO - Installing collected packages: mozsystemmonitor 07:37:41 INFO - Running setup.py install for mozsystemmonitor 07:37:41 INFO - Successfully installed mozsystemmonitor 07:37:41 INFO - Cleaning up... 07:37:41 INFO - Return code: 0 07:37:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37:41 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 07:37:41 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 07:37:41 INFO - Using env: {'DISPLAY': ':0', 07:37:41 INFO - 'HOME': '/home/cltbld', 07:37:41 INFO - 'LANG': 'en_US.UTF-8', 07:37:41 INFO - 'LANGUAGE': 'en_US:en', 07:37:41 INFO - 'LOGNAME': 'cltbld', 07:37:41 INFO - 'MAIL': '/var/mail/cltbld', 07:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:41 INFO - 'MOZ_NO_REMOTE': '1', 07:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:41 INFO - 'NO_EM_RESTART': '1', 07:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:41 INFO - 'PWD': '/builds/slave/test', 07:37:41 INFO - 'SHELL': '/bin/bash', 07:37:41 INFO - 'SHLVL': '1', 07:37:41 INFO - 'TERM': 'linux', 07:37:41 INFO - 'TMOUT': '86400', 07:37:41 INFO - 'USER': 'cltbld', 07:37:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:41 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:44 INFO - warning: no files found matching '*.txt' 07:37:44 INFO - no previously-included directories found matching 'build' 07:37:44 INFO - no previously-included directories found matching 'dist' 07:37:44 INFO - no previously-included directories found matching '.git*' 07:37:44 INFO - Installing collected packages: jsonschema, functools32 07:37:44 INFO - Running setup.py install for functools32 07:37:44 INFO - warning: no files found matching '*.txt' 07:37:44 INFO - no previously-included directories found matching 'build' 07:37:44 INFO - no previously-included directories found matching 'dist' 07:37:44 INFO - no previously-included directories found matching '.git*' 07:37:44 INFO - Successfully installed jsonschema functools32 07:37:44 INFO - Cleaning up... 07:37:44 INFO - Return code: 0 07:37:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:44 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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37:44 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 07:37:44 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 07:37:44 INFO - Using env: {'DISPLAY': ':0', 07:37:44 INFO - 'HOME': '/home/cltbld', 07:37:44 INFO - 'LANG': 'en_US.UTF-8', 07:37:44 INFO - 'LANGUAGE': 'en_US:en', 07:37:44 INFO - 'LOGNAME': 'cltbld', 07:37:44 INFO - 'MAIL': '/var/mail/cltbld', 07:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:44 INFO - 'MOZ_NO_REMOTE': '1', 07:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:44 INFO - 'NO_EM_RESTART': '1', 07:37:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:44 INFO - 'PWD': '/builds/slave/test', 07:37:44 INFO - 'SHELL': '/bin/bash', 07:37:44 INFO - 'SHLVL': '1', 07:37:44 INFO - 'TERM': 'linux', 07:37:44 INFO - 'TMOUT': '86400', 07:37:44 INFO - 'USER': 'cltbld', 07:37:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:44 INFO - '_': '/tools/buildbot/bin/python'} 07:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:47 INFO - Downloading docopt-0.6.1.tar.gz 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:47 INFO - Running setup.py install for blobuploader 07:37:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:47 INFO - Running setup.py install for requests 07:37:47 INFO - Running setup.py install for docopt 07:37:47 INFO - Successfully installed blobuploader requests docopt 07:37:47 INFO - Cleaning up... 07:37:47 INFO - Return code: 0 07:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37:47 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 07:37:47 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 07:37:47 INFO - Using env: {'DISPLAY': ':0', 07:37:47 INFO - 'HOME': '/home/cltbld', 07:37:47 INFO - 'LANG': 'en_US.UTF-8', 07:37:47 INFO - 'LANGUAGE': 'en_US:en', 07:37:47 INFO - 'LOGNAME': 'cltbld', 07:37:47 INFO - 'MAIL': '/var/mail/cltbld', 07:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:47 INFO - 'MOZ_NO_REMOTE': '1', 07:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:47 INFO - 'NO_EM_RESTART': '1', 07:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:47 INFO - 'PWD': '/builds/slave/test', 07:37:47 INFO - 'SHELL': '/bin/bash', 07:37:47 INFO - 'SHLVL': '1', 07:37:47 INFO - 'TERM': 'linux', 07:37:47 INFO - 'TMOUT': '86400', 07:37:47 INFO - 'USER': 'cltbld', 07:37:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:47 INFO - '_': '/tools/buildbot/bin/python'} 07:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:47 INFO - Running setup.py (path:/tmp/pip-V6IkvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:48 INFO - Running setup.py (path:/tmp/pip-r5JJeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:48 INFO - Running setup.py (path:/tmp/pip-QX2MZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:48 INFO - Running setup.py (path:/tmp/pip-nSpir4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:48 INFO - Running setup.py (path:/tmp/pip-aTypQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:48 INFO - Running setup.py (path:/tmp/pip-A6rLZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:48 INFO - Running setup.py (path:/tmp/pip-XkWWKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:48 INFO - Running setup.py (path:/tmp/pip-eddDYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:48 INFO - Running setup.py (path:/tmp/pip-kqqhII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:48 INFO - Running setup.py (path:/tmp/pip-sjFdIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:48 INFO - Running setup.py (path:/tmp/pip-y0fX8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:48 INFO - Running setup.py (path:/tmp/pip-DC1SZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:48 INFO - Running setup.py (path:/tmp/pip-zkmGvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:48 INFO - Running setup.py (path:/tmp/pip-mbxJRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:48 INFO - Running setup.py (path:/tmp/pip-MA_SN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:49 INFO - Running setup.py (path:/tmp/pip-ZypvkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:49 INFO - Running setup.py (path:/tmp/pip-GJppv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:49 INFO - Running setup.py install for manifestparser 07:37:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozcrash 07:37:49 INFO - Running setup.py install for mozdebug 07:37:49 INFO - Running setup.py install for mozdevice 07:37:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozfile 07:37:49 INFO - Running setup.py install for mozhttpd 07:37:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozinfo 07:37:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozInstall 07:37:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozleak 07:37:50 INFO - Running setup.py install for mozlog 07:37:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for moznetwork 07:37:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozprocess 07:37:50 INFO - Running setup.py install for mozprofile 07:37:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozrunner 07:37:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozscreenshot 07:37:50 INFO - Running setup.py install for moztest 07:37:50 INFO - Running setup.py install for mozversion 07:37:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:50 INFO - Cleaning up... 07:37:50 INFO - Return code: 0 07:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37: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 07:37: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 07:37:50 INFO - Using env: {'DISPLAY': ':0', 07:37:50 INFO - 'HOME': '/home/cltbld', 07:37:50 INFO - 'LANG': 'en_US.UTF-8', 07:37:50 INFO - 'LANGUAGE': 'en_US:en', 07:37:50 INFO - 'LOGNAME': 'cltbld', 07:37:50 INFO - 'MAIL': '/var/mail/cltbld', 07:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:50 INFO - 'MOZ_NO_REMOTE': '1', 07:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:50 INFO - 'NO_EM_RESTART': '1', 07:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:50 INFO - 'PWD': '/builds/slave/test', 07:37:50 INFO - 'SHELL': '/bin/bash', 07:37:50 INFO - 'SHLVL': '1', 07:37:50 INFO - 'TERM': 'linux', 07:37:50 INFO - 'TMOUT': '86400', 07:37:50 INFO - 'USER': 'cltbld', 07:37:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:50 INFO - '_': '/tools/buildbot/bin/python'} 07:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:51 INFO - Running setup.py (path:/tmp/pip-Qxk8un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:51 INFO - Running setup.py (path:/tmp/pip-lRoGD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:51 INFO - Running setup.py (path:/tmp/pip-h98iYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:51 INFO - Running setup.py (path:/tmp/pip-c0zprU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:51 INFO - Running setup.py (path:/tmp/pip-YimFvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:51 INFO - Running setup.py (path:/tmp/pip-NyuNlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:51 INFO - Running setup.py (path:/tmp/pip-hlSVcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:51 INFO - Running setup.py (path:/tmp/pip-W3pfSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37: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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:51 INFO - Running setup.py (path:/tmp/pip-Tm1dJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37: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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:51 INFO - Running setup.py (path:/tmp/pip-awTmeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37: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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 INFO - Running setup.py (path:/tmp/pip-ScKH1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37: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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 INFO - Running setup.py (path:/tmp/pip-QzCN8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:52 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)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:52 INFO - Running setup.py (path:/tmp/pip-ZChsde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:52 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)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:52 INFO - Running setup.py (path:/tmp/pip-XkUSkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:52 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)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:52 INFO - Running setup.py (path:/tmp/pip-NM6o_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:52 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)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:52 INFO - Running setup.py (path:/tmp/pip-2u2Uvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:52 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)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:52 INFO - Running setup.py (path:/tmp/pip-Jsi5Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:52 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)) 07:37:52 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)) 07:37:52 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)) 07:37:52 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)) 07:37:52 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)) 07:37:52 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)) 07:37:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:54 INFO - Downloading blessings-1.6.tar.gz 07:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:54 INFO - Installing collected packages: blessings 07:37:54 INFO - Running setup.py install for blessings 07:37:54 INFO - Successfully installed blessings 07:37:54 INFO - Cleaning up... 07:37:54 INFO - Return code: 0 07:37:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:54 INFO - Reading from file tmpfile_stdout 07:37:54 INFO - Current package versions: 07:37:54 INFO - argparse == 1.2.1 07:37:54 INFO - blessings == 1.6 07:37:54 INFO - blobuploader == 1.2.4 07:37:54 INFO - docopt == 0.6.1 07:37:54 INFO - functools32 == 3.2.3-2 07:37:54 INFO - jsonschema == 2.5.1 07:37:54 INFO - manifestparser == 1.1 07:37:54 INFO - mozInstall == 1.12 07:37:54 INFO - mozcrash == 0.17 07:37:54 INFO - mozdebug == 0.1 07:37:54 INFO - mozdevice == 0.48 07:37:54 INFO - mozfile == 1.2 07:37:54 INFO - mozhttpd == 0.7 07:37:54 INFO - mozinfo == 0.9 07:37:54 INFO - mozleak == 0.1 07:37:54 INFO - mozlog == 3.2 07:37:54 INFO - moznetwork == 0.27 07:37:54 INFO - mozprocess == 0.23 07:37:54 INFO - mozprofile == 0.28 07:37:54 INFO - mozrunner == 6.12 07:37:54 INFO - mozscreenshot == 0.1 07:37:54 INFO - mozsystemmonitor == 0.3 07:37:54 INFO - moztest == 0.7 07:37:54 INFO - mozversion == 1.4 07:37:54 INFO - psutil == 3.1.1 07:37:54 INFO - requests == 1.2.3 07:37:54 INFO - wsgiref == 0.1.2 07:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37: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 07:37: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 07:37:54 INFO - Using env: {'DISPLAY': ':0', 07:37:54 INFO - 'HOME': '/home/cltbld', 07:37:54 INFO - 'LANG': 'en_US.UTF-8', 07:37:54 INFO - 'LANGUAGE': 'en_US:en', 07:37:54 INFO - 'LOGNAME': 'cltbld', 07:37:54 INFO - 'MAIL': '/var/mail/cltbld', 07:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:54 INFO - 'MOZ_NO_REMOTE': '1', 07:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:54 INFO - 'NO_EM_RESTART': '1', 07:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:54 INFO - 'PWD': '/builds/slave/test', 07:37:54 INFO - 'SHELL': '/bin/bash', 07:37:54 INFO - 'SHLVL': '1', 07:37:54 INFO - 'TERM': 'linux', 07:37:54 INFO - 'TMOUT': '86400', 07:37:54 INFO - 'USER': 'cltbld', 07:37:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:54 INFO - '_': '/tools/buildbot/bin/python'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 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 0x21c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', '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 07:37:55 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 07:37:55 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 07:37:55 INFO - Using env: {'DISPLAY': ':0', 07:37:55 INFO - 'HOME': '/home/cltbld', 07:37:55 INFO - 'LANG': 'en_US.UTF-8', 07:37:55 INFO - 'LANGUAGE': 'en_US:en', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MAIL': '/var/mail/cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SHLVL': '1', 07:37:55 INFO - 'TERM': 'linux', 07:37:55 INFO - 'TMOUT': '86400', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - '_': '/tools/buildbot/bin/python'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Running post-action listener: _resource_record_post_action 07:37:55 INFO - Running post-action listener: _start_resource_monitoring 07:37:55 INFO - Starting resource monitoring. 07:37:55 INFO - ##### 07:37:55 INFO - ##### Finished create-virtualenv step (success) 07:37:55 INFO - ##### 07:37:55 INFO - ##### 07:37:55 INFO - ##### Running install step. 07:37:55 INFO - ##### 07:37:55 INFO - Running pre-action listener: _resource_record_pre_action 07:37:55 INFO - Running main action method: install 07:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Output received: 07:37:55 INFO - Usage: mozinstall [options] installer 07:37:55 INFO - Options: 07:37:55 INFO - -h, --help show this help message and exit 07:37:55 INFO - -d DEST, --destination=DEST 07:37:55 INFO - Directory to install application into. [default: 07:37:55 INFO - "/builds/slave/test"] 07:37:55 INFO - --app=APP Application being installed. [default: firefox] 07:37:55 INFO - mkdir: /builds/slave/test/build/application 07:37:55 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'] 07:37:55 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 07:38:12 INFO - Reading from file tmpfile_stdout 07:38:12 INFO - Output received: 07:38:12 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:12 INFO - Running post-action listener: _resource_record_post_action 07:38:12 INFO - ##### 07:38:12 INFO - ##### Finished install step (success) 07:38:12 INFO - ##### 07:38:12 INFO - ##### 07:38:12 INFO - ##### Running run-tests step. 07:38:12 INFO - ##### 07:38:12 INFO - Running pre-action listener: _resource_record_pre_action 07:38:12 INFO - Running main action method: run_tests 07:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:12 INFO - Python 2.7.3 07:38:12 INFO - Return code: 0 07:38:12 INFO - grabbing minidump binary from tooltool 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:12 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 0x24803b0>, '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 0x24812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2481740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:12 INFO - Return code: 0 07:38:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 07:38:12 INFO - Using env: {'DISPLAY': ':0', 07:38:12 INFO - 'HOME': '/home/cltbld', 07:38:12 INFO - 'LANG': 'en_US.UTF-8', 07:38:12 INFO - 'LANGUAGE': 'en_US:en', 07:38:12 INFO - 'LOGNAME': 'cltbld', 07:38:12 INFO - 'MAIL': '/var/mail/cltbld', 07:38:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:12 INFO - 'MOZ_NO_REMOTE': '1', 07:38:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:12 INFO - 'NO_EM_RESTART': '1', 07:38:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:12 INFO - 'PWD': '/builds/slave/test', 07:38:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:12 INFO - 'SHELL': '/bin/bash', 07:38:12 INFO - 'SHLVL': '1', 07:38:12 INFO - 'TERM': 'linux', 07:38:12 INFO - 'TMOUT': '86400', 07:38:12 INFO - 'USER': 'cltbld', 07:38:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287', 07:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:12 INFO - '_': '/tools/buildbot/bin/python'} 07:38:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:38:13 INFO - mozversion application_buildid: 20160713163005 07:38:13 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:38:13 INFO - mozversion application_display_name: Nightly 07:38:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:13 INFO - mozversion application_name: Firefox 07:38:13 INFO - mozversion application_remotingname: firefox 07:38:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:13 INFO - mozversion application_vendor: Mozilla 07:38:13 INFO - mozversion application_version: 50.0a1 07:38:13 INFO - mozversion platform_buildid: 20160713163005 07:38:13 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:38:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:13 INFO - mozversion platform_version: 50.0a1 07:38:13 INFO - using testdate: 1468593493 07:38:13 INFO - actual date: 1468593493 07:38:13 INFO - starting webserver on 'localhost:40884' 07:38:13 INFO - SUITE-START | Running 2 tests 07:38:13 INFO - TEST-START | dromaeo_css 07:38:13 INFO - operating with platform_type : linux_ 07:38:13 INFO - Initialising browser for dromaeo_css test... 07:38:13 INFO - TEST-INFO | started process 4252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZsUbS/profile http://localhost:40884/getInfo.html) 07:38:18 INFO - PROCESS | 4252 | __metrics Screen width/height:1600/1200 07:38:18 INFO - PROCESS | 4252 | colorDepth:24 07:38:18 INFO - PROCESS | 4252 | Browser inner width/height: 1024/697 07:38:18 INFO - PROCESS | 4252 | __metrics 07:38:18 ERROR - PROCESS | 4252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:38:19 INFO - TEST-INFO | 4252: exit 0 07:38:19 INFO - Browser initialized. 07:38:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:19 INFO - TEST-INFO | started process 4372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZsUbS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:31 INFO - PROCESS | 4372 | RSS: Main: 167112704 07:38:31 INFO - PROCESS | 4372 | 07:39:20 INFO - PROCESS | 4372 | 1468593560806 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] 07:41:28 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40884/tests/dromaeo/cssquery-ext.html) 07:41:29 INFO - PROCESS | 4372 | RSS: Main: 171327488 07:41:29 INFO - PROCESS | 4372 | 07:44:31 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-ext.html (next: http://localhost:40884/tests/dromaeo/cssquery-jquery.html) 07:44:32 INFO - PROCESS | 4372 | RSS: Main: 167858176 07:44:32 INFO - PROCESS | 4372 | 07:47:34 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40884/tests/dromaeo/cssquery-mootools.html) 07:47:34 INFO - PROCESS | 4372 | RSS: Main: 171016192 07:47:34 INFO - PROCESS | 4372 | 07:50:36 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40884/tests/dromaeo/cssquery-prototype.html) 07:50:37 INFO - PROCESS | 4372 | RSS: Main: 166428672 07:50:37 INFO - PROCESS | 4372 | 07:53:39 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40884/tests/dromaeo/cssquery-yui.html) 07:53:40 INFO - PROCESS | 4372 | RSS: Main: 168689664 07:53:40 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | Cycle 1(1): loaded http://localhost:40884/tests/dromaeo/cssquery-yui.html (next: http://localhost:40884/tests/dromaeo/cssquery-dojo.html) 07:56:42 INFO - PROCESS | 4372 | RSS: Main: 169672704 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | __start_tp_report 07:56:42 INFO - PROCESS | 4372 | _x_x_mozilla_page_load 07:56:42 INFO - PROCESS | 4372 | _x_x_mozilla_page_load_details 07:56:42 INFO - PROCESS | 4372 | |i|pagename|runs| 07:56:42 INFO - PROCESS | 4372 | |0;dojo.html;3068.923276918077;3130.2174456385887;3142.261568531395;3162.114607909786;3175.079227024163;5512;5529.225908372831;5561.9721901390485;5635.21107045014;5637.943620563803;5395.514403703666;5470.863228419282;5522.972385138079;5542.528885044766;5553.111502159645;4975.502449755032;4999.375078115236;5090.567301779353;5136.58907287418;5189.506996835314;641.1520656356117;4895.951040489603;4975.104481193383;5021.17150670139;5063.46833582474;5014.2979982802435;5024.371953505812;5045.293658887758;5058.038972595214;5060.645754797166;5065.392152941634;5069.366329208849;5090.694558326512;5097.286379906779;5111.897762044739;4944.653874228806;4966.230234313687;5021.096202683516;5044.268581055726;5050.2929589857085;5494.450554944514;5551.3893471718075;5565.332160140809;5577.832665020056;5623.746931388097;5679.261695979538;5812.941870581282;5939.554533409968;5960.880782384372;5962.2249107615735;5853.941460585383;5890.293164820207;5909.556783241274;5924.407559244084;5972.044472884318;5455.372632147314;5468.91796623051;5469.56243500519;5476.041692703761;5481.5340696040885;5851.297844258716;5996.4603185713495;6015.0977353396465;6027.547933904974;6077.696115194222;5834.154047663065;5841.591088623755;5844.912326315109;5849.970750146222;5875.970620146872;5916.526677865761;5919.704014799329;5921.3190483094995;5924.318703349084;5952.553558483131;5665.263515742927;5834.737436815353;5861.120831875168;5897;5903.822885313448;5917.467427931507;5921;5923.111533269957;5930.436608522184;5937.465628093492;4451.06527629195;4468.4637843458995;4495.325701144789;4495.842645507457;4555;3930.7051971102283;3932.05630648648;3945.6251656092627;3955.011247188203;4016.357382818735;5518.144687573433;5559.16612508127;5568.109102543654;5608.10270356741;5629.521490673339;5837.328707198726;5965.343812180743;5970.492508136857;5975.223220981332;5980.43185897339;5470.206820011155;5531.778728850882;5550.417206193372;5561.193626924073;5588.86027849307;5080.796768129233;5093.337866077386;5095.77069031887;5099.923501147486;5101.69389836611;6104.847378815476;6114.48026917717;6119.173911521976;6124.234470691164;6124.989376752875;5733.913991290134;5848.853778655568;5888.882222355443;5932.79235226765;5961.135635332939;6110.938890611037;6118.143459915526;6121.816345509642;6123.2652081750475;6126.877462450815;5661.943380566142;5807.186993820784;5836.533077353716;5843.415658434123;5844.824655260349;5872.265966754156;5918.496927761188;5944.138099975393;5971.044632858721;5987.31145918225;5763.077907534775;5798.82603521895;5821.650700957956;5821.825345239649;5842.38654941225;5653.3498647654405;5754.424557544212;5790.10253410722;5794.333651630117;5815.3893841147765;5742.339630942495;5781.94218057814;5783;5789.363170051375;5803.912941305968;5713.885722285614;5781.075027995501;5854.121881717776;5863.20846685692;5883.705814709333;5555.333359996826;5687.374388817309;5702;5731.254936858182;5734.283214598176 07:56:42 INFO - PROCESS | 4372 | |1;ext.html;550.6808715529855;584.7310237290847;591.0897218283843;594.5511139089987;619.9039148931918;39813;43675;43723.78138109313;43793.90515237117;43803.561964380344;45065.549344506544;45589.31616025754;45794.313085303744;45956.54043459564;45966;8824.338174636896;8866;8934.731958041237;8970.327225458117;8980.685676001342;8669.869951950726;8745.212930836224;8783.78040548985;8784.429012114193;8792.296616270683;8779.2098711116;8821.955890220572;8844.601992910302;8853.778655533599;8857.070007649201;8678.696245631405;8680.739577812676;8782.25350845179;8828.07305232951;8845.646174153026;8772.473651580925;8858.73423797287;8864;8867.911320886773;8885.333599980027;42501.362479562835;42560;42605.78697106526;42797.78601107006;42823.35764963528;3551.1122219445137;3597.244578638489;3623.2934577757346;3707.480952666629;3759.6240375962457;33511;34325.828370857984;34450;34610;34884;4535.931961020588;4538.52345503724;4572.154151481986;4609.446866376023;4646.86059418218;387302;388994;389630;389894;390237;63186;63586;63646;63689.36310636927;63761.68119159374;36384.09039773974;37131.443028354595;37148.44277335788;38221.61778382236;67392.6630366845;17343.826561734473;17455.65088698219;17546.38587649426;17581.208845601977;17597.472075837744;13458.798118028237;13468.595942121752;13514.59456216315;13519;13584;20406.69389959152;20462.79537204609;20575.897120514303;20586.176552938014;20605.48486287825;7032.8945065824055;7038.612876291751;7237.62485127824;7272.672759707965;7275.454340924452;967.5114067396061;1038.0449986012886;1091.6670415523183;1094.7810437912449;1204.145057009533;34048;34111.65888341134;34233.31533369319;34312.828435857664;34554.6415165444;1110.640313053005;1172.9530818767325;1200.5737963023175;1223.9877601224052;1233.8951189148843;17680.646387072185;17958.461246162635;17966.640667186846;17983.64032719338;17993.370232041816;608661;610476;611746;613401;614555;62666.68666656638;62837.685811571566;63358.68320658367;63496.68251658712;63575.36424635694;1281.833361662978;1361.2241022617013;1375.3329635126756;1380.2615600653603;1381.5855243426931;31925.521117182798;33326.83336583398;33516.82691105799;33555.66444335623;33690;54274.45725542694;54287.72856135694;54424;54491.45508544864;54568.45431545792;489266;491426;492416;495839;496138;28304.575431368135;28766.568501472913;29516.557251640814;29613;30268.394632106792;47585.81035474141;48416.5158348412;50419.243711343624;50700.49299506958;51330;42569;43170.352444713986;43257;44041;44910.10179796451;42357;42387.788061059495;43411.131777364906;44158.11683766371;44898.3265251015;41921;42376.15247694967;42428;42816.78591607022;43513;38369.42445863259;38773.41839872461;38832.53425856063;39595.80202098971;39909.2018159641;29287.853560732914;29292.56061159127;29417.264568385963;29761.702382975895;29802.701972979994 07:56:42 INFO - PROCESS | 4372 | |2;jquery.html;385.2180074448866;386.35285896123986;393.50221969208957;401.2516656435747;410.2205808962972;14211.289435528208;18869.905650471745;19324.420267391964;20260;20482.2831200908;19059.332923347687;19435;19588.804111958878;19595.118219680113;19813.702794458095;5652.830415087554;5693.089105743082;5810.680412577307;5829.621074630157;5831.825045248649;5627.071533197018;5642.943570564304;5739.3399759027825;5747.712614369286;5755.25181726375;5547.750351234184;5641.492265696086;5723.656580605177;5734.713264336767;5753.079507278836;5634.4928956393915;5636.379998200195;5643.6049476536655;5681.034224181878;5716.942830571704;4947.183714687072;5254.474552544753;5277.7361131943635;5324.361076670824;5331.120365139747;13794.448222071105;13914.165150091027;14365.569032929028;14369.71260574793;14413.927930360282;2240.406292332533;2378.7996103604096;2411.276617014906;2573.4853029394008;2615.6599642046604;9968.850467242997;10546.314489558154;10560;12630.621081367573;13920.164790112525;1931.5364312565023;1934.5937353155714;1953.7007889753297;1972.5265936175358;1983.7917018712972;84845.57577212075;88005.55997219973;89249.55375223083;90007.54996225043;90434.54782726044;11119.777604447865;11198.720031999264;11227.438628068563;11414.086873050135;11582.710432239093;15649.530514084596;15715;15757.054576725204;15771.05373677583;15876.60308492297;7914.327282180964;8002.3598112150885;8089.635966381527;8166.550839703755;8372;7815.53106813593;7934.563599001995;7979.521228726295;8006.71976480832;8016.839663206703;4802.855914322576;4828.879278018007;4830.178869592178;4843.200871856105;4955.1823949048;2001.1995201919349;2028.2900984655253;2048.5902819436174;2058.259026750369;2098.6642137257963;953.3326671330096;1000.3947611694965;1004.4124187350336;1020.7703266764919;1047.5914393386586;19629.331506821796;20077.598448030956;20079.799202008086;20372.185112595627;20508.69236961447;1038.1020417338948;1050.9421981791074;1051.9316244444087;1055.6041484443333;1078.7950289445137;10735.248532602798;11203.271787333797;11245.94377028126;11255.155863310285;11388.259763115371;541321;552816;553944;554292;558864;83254;90274;92750.53624731833;97680.51159744155;101248;1025.933314334566;1028.0798685176874;1060.4326685223368;1062.8786630105312;1065.4938904020682;17492.562685932953;17686.11569421498;18108.185131668844;18257.269709211483;18520.0739963004;44881.55118448774;45458;45467.772661136485;45785.855353616425;45791.54208457873;62490;63303.36696633159;63740.3625963753;64160.67919660372;64731;8340.124286949784;8499.575021249037;8607.18231767981;8800.075992020746;8899.199072083544;11195.944020279847;12395.442205100973;12554.748905021666;13414.664633384244;13604.727905441638;11144.164187685794;11145.554177832795;11360.375179365214;11824.1131915105;11829.112816538965;10074;11835.11236657237;11842.940785296363;11901.226420282654;12024.519019239133;11866.347350895783;11888.405579720806;11916.880831191924;12053.457594408097;12088.879111208775;7460.29127232912;7613.695452182073;7848.882266765889;8045.758627241192;8480.363972701949;10940;11400.372979486208;11487.94256028748;11512.654620361403;11653.708657283296 07:56:42 INFO - PROCESS | 4372 | |3;mootools.html;1463.7292100961322;1494.140869000325;1647.1270226779804;1789.3737191982816;1813.791413987391;7630.236976302367;8286.709965151222;8459.111793261696;8891.333150013743;8905.287576993842;8428.283595894341;8735.91264087359;8808.603612837422;8812.955935220314;8813.471191728484;2333.4283100640323;2347.424880904181;2363.3500787283547;2364.196173301077;2376.7504412036747;2301.5972204864083;2315.710536182977;2355.7290911545133;2381.6784734060852;2383.678203442539;2326.9534609307802;2366.325597204797;2374.881255937205;2393.2102406205995;2396.1733202045266;2349.81201503881;2365.5978483657645;2366.668666386707;2378.0963233971065;2378.6907701998716;2312.17917639239;2329.5340931813703;2329.883505824719;2340.157543284416;2345.413646588353;8777.078406767261;8801.735947921572;8891.19979201875;8891.33315001371;8907.198352148338;5077.923831142499;5122.129238029544;5175.068487672217;5182.766775495112;5193.065248255312;3464.497647841074;3473.9652603473896;3493.7205023598303;3545.0782796472845;3552.1119720069983;1262.652770488114;1268.987310126896;1271.3452571925466;1275.8086287057015;1299.2529295654942;12127.939360303142;12163;12165.878341216563;12221.266723996589;12235.265884046985;4382.912341753211;4499.955000449953;4615.446146462446;4628.097520983443;4697.4832768395445;10143.239257055602;10151.187904967584;10163.898361016443;10171.338862973884;10179.185665146919;5294.602904782157;5316.255724198615;5316.627836051517;5317.574594032468;5325.8934821303355;4236.597523235288;4630.6063984561015;4821.276808478686;4823.9517604824205;4875.43932447773;3786.5077539919635;3856.3636999895266;3961.267165574378;3963.1677347757295;4007.8196481158416;1220.5850010996303;1230.6492649594823;1248.2822377133184;1249.575144450891;1262.5959692898184;840.2521755637488;956.086936975187;966.2897770138942;978.2223132609593;1005.2360206243162;5708.257926469615;5795.594308398456;5847.649141051551;5926.081457374114;5965.985782416999;462.17732436263503;466.3424571354374;468.08255818595256;470.6187987729881;471.7381005809446;4211.136716973013;4265.912192390921;4268.935965960513;4290.978545107317;4302.978485107555;10683;10909.890901090888;10951.56193752241;10959.50682219302;10995.890041099647;10224.488775561193;10860.619878304222;10868.347899126078;10905.34567925927;10942.343459392461;7865.842683146419;8070.556119413372;8136.959315203386;8149.225823546753;8218.013838339437;5985.730642121028;6078.90881636767;6145.938540614716;6178.104174894705;6320.083587879823;9735.123838854537;10131.240156988108;10197.439140847027;10236.33463824849;10283.485825708834;10301.74245643865;10316.690499285034;10358.896411036094;10432.374057556268;10432.895671043496;7116.857662846817;7714.421418393531;7745.922540774745;7833.1775163607;7882.84234315299;8571.528565928933;8696.739097827076;8702.347323950602;8726.869096963677;8821.691240806542;7515.586642734484;7734.613269336398;7748.108967468813;7770.417218708732;7940.126586075643;7705.190954949874;7823.217678232131;7826.334761545332;7892.0529536456;7904.328132108835;7010.579365238102;7022.192447868356;7041.718331266692;7051.929480705127;7084.787456376317;4841.031793641216;5119.078565858182;5231.4768523148905;5302.310699609026;5306.9203961941375;5164.457731938242;5224.60815438836;5360.212222674735;5424.430434804289;5491.28613280287 07:56:42 INFO - PROCESS | 4372 | |4;prototype.html;314.2458100558659;330.43825496655677;333.4065363652696;334.3530268929621;337.13188539510764;5477.315335583052;5481.671099734019;5664.348599911012;5705.315362156542;5714.114312281597;5505.284313039299;5524.917126243109;5540.445955404458;5541.085720856054;5546.944530554693;4365.934510982338;4395.626371758404;4404.845830395929;4406.779661016953;4425.579569940851;4081.755034730901;4270.743755374688;4282.164977829325;4415.67529741078;4447.799849006787;4232.830686772525;4257.191133684605;4263.445752052245;4277.74333539987;4294.849680261192;4296.677749168824;4298.204832106055;4314.266574682311;4316.309390497537;4338.262495375794;3578.4095624221973;3758.455024021529;3767.9623203767887;3773.5471743390694;3781.546214454283;5432;5471.398146203915;5477.315335583052;5486.177073438977;5500.559955203574;4898.632602554822;4902.4852390498845;4905.8773530661665;4938.753062346904;4960.1567733485035;5538.479991603811;5828.562857785683;5839.445252700986;5858.76564937402;5871.236739223874;4157.833686652531;4158.8336466541305;4183.330667093281;4188.308929026707;4202.621764041251;6051.334353221142;6093.086037094427;6134.723937422782;6161.260648722137;6171.086963041426;4168.749875007509;4258.339957306623;4266.914661706811;4283.87148385549;4289.206496798102;4313.094250207429;4314.676399270004;4334.718243314174;4359.215341238608;4362.520122786491;4959.330490383824;4965.726885021286;4965.826196083192;4974.801007959641;4991.151504244214;5674.659520428705;5821.388754180834;5836.124581312837;5948.137520059654;5956.761729530857;1454.5854431487187;1461.663817322022;1463.2610531681432;1473.5873955292536;1478.0909740509724;907.841127802632;926.282131348197;933.421278807144;936.3679516326453;951.1297163095828;4882.389701287339;4912.606991440676;4952.727599981963;4974.980129073531;4991.226359914219;5252.737363131828;5259.15853463444;5330.973345133327;5342.572594192456;5397.73011349431;4649.814007439664;4949.461135288286;4958.330625365602;4983.975080124576;4989.900201996013;2815.47913635978;2842.3178437175343;2875.611792407998;2884.6586337353233;2884.9614138909974;5415.729213539307;5470.140152348221;5510.201020852034;5510.752016159283;5546.251256080458;5196.934628401169;5392.4948783291175;5403.83788486346;5420.728963551806;5423;5455.945440545624;5463.672179669233;5464.753836317101;5474.576610081328;5498.927709096768;5098.439171691037;5301.6818990860675;5316.680999140064;5337.199420087018;5386.380566234933;5213.843584692465;5242.921356179737;5289.143862314308;5314.202869569441;5322.840314790563;5491.917621235764;5515.669059856422;5599.776008959596;5876.676782776988;5955.821325360246;4169.478815148106;4176.9164616706885;4224.218519573888;4229.788510574521;4240.597143271384;6015.796840631979;6021;6023.27720673522;6048.304444988883;6058.242719660043;5680.2107336188965;5828.912566311424;5833.79581714638;5835.94164058371;5854.443827836349;5777.942220577908;5787.56593255516;5793.594448388572;5794.333651630117;5804.1874137619925;5523.475269849358;5736.856578585402;5762.732198916232;5808.651480911159;5809.970950145223;5929.347771745191;5939;5945.227120474311;5961.701914904151;5979.701014949323;5761.56788240892;5824.271966004249;5837.737301821343;5854.619449735754;5854.9121763174435 07:56:42 INFO - PROCESS | 4372 | |5;yui.html;710.9608971506568;755.7241606813513;795.3915254830052;808.6037841457686;837.8408102460528;15930.761038584416;16165.919170404131;16284.511464656065;16314.673706525862;16368.099754513498;14769.556913292592;14920.104793712384;14927.552173434788;14933.701325973474;14975.47585834496;662.8011596521036;790.5849429049766;797.1629788721848;801.4349883332237;811.9797005074861;808.7169490678274;810.6149578949982;811.6591031766673;812.5124925044985;814.2549567146054;871.2028493928049;874.1608056265992;877.9473231606124;880.55972013993;881.8456770065245;872.4372779557182;875.5972252763736;878.3061381508601;878.6002368922188;878.6836738774068;634.4987459906669;635.8442181665475;640.2381166411955;641.5637366590717;643.893757530007;14888.553343399715;14960.850391496164;14994.850051499563;15003.32485038165;15008.324625391884;15541.222938853125;15595.152536492258;15934.681306373808;16128.274227659784;16417.343306267736;12532.937335313356;12599.559015434415;12727.809082863765;12827.422765975554;12915.87084129156;3907.1404291056206;3944.861929832442;3982.283189025974;4001.4998125234347;4151;74311.62844185799;76287;76708;78327.21672783257;79581.20418795796;12149.453274602663;12201.38993050344;12318.938405307916;12408.937955310166;12459.750804983849;23138.537229255657;23156.65265021026;23188.53622927532;23193.304200874;23210.1876434324;8879.200871921557;8880.111988801069;8940.240079593177;9077.909220907839;9306.813863722688;4865.829695960624;4980.7509624518625;5041.495850415003;5056.317397151411;5093;3591.964080359215;3677.9701683528656;3705.184859330943;3709.629037096269;3710.6289371063217;650.9804705858832;652.9085927970089;663.8705452436728;664.1565212180503;668.9498287628447;581.5522048023083;695.6000299827518;700.3276854220006;716.1799739298474;724.3589423360364;9377.859332110023;9496.572654230577;9560.808783824423;9910.702678919644;9984.301098923006;634.7810005548079;699.6152116335995;704.520925770481;705.6048612776862;706.1914108345915;4771.379720636364;4838.201696720002;4840.588549973291;4891.144049791273;4923.48303428142;99079;114988;117416;117673;121849;103408;104046.47976760218;104626;106444.46777766061;107389.46305268424;53048.93902121936;55348.72325638426;56122.438775612536;93335;93872.49020078377;8733.257673097858;8890.377673563047;9015.413998090366;9129.954350228207;9157.771055723393;55237.72381138069;55472.44527554673;56255.71872140777;57048.42951570431;57395.99999999833;77705.83441248273;79785.60107199427;79932;80582;81492.18507815083;10974.176936729618;11227.663170104583;11262.718432039264;11341.036011938748;11695.649130526097;12215.633530994084;12625.431855566705;13005.544805931748;13043.934780326417;13117.672058198621;11890.34603096838;12009.159358845147;12065.698357541132;12118.151729378858;12362.938185309016;12123.333216673167;12185.329806860707;12328.876711233132;12529.686757831127;12623.873761262637;12241.693957650774;12254.387280635754;12321.568745093879;12592.496300148257;12802.871971280541;10269.74325641865;10696.304740191863;10780.137588992706;10794;10822.783544328911;10193.337433066827;10245.077942985166;10395.792084158425;10445.843312350473;10611.628592999208 07:56:42 INFO - PROCESS | 4372 | __end_tp_report 07:56:42 INFO - PROCESS | 4372 | __start_cc_report 07:56:42 INFO - PROCESS | 4372 | _x_x_mozilla_cycle_collect,392 07:56:42 INFO - PROCESS | 4372 | __end_cc_report 07:56:42 INFO - PROCESS | 4372 | __startTimestamp1468594602720__endTimestamp 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | ------- Summary: start ------- 07:56:42 INFO - PROCESS | 4372 | Number of tests: 6 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#0] dojo.html Cycles:165 Average:5460.22 Median:5731.25 stddev:737.60 (12.9%) stddev-sans-first:715.61 07:56:42 INFO - PROCESS | 4372 | Values: 3068.9 3130.2 3142.3 3162.1 3175.1 5512.0 5529.2 5562.0 5635.2 5637.9 5395.5 5470.9 5523.0 5542.5 5553.1 4975.5 4999.4 5090.6 5136.6 5189.5 641.2 4896.0 4975.1 5021.2 5063.5 5014.3 5024.4 5045.3 5058.0 5060.6 5065.4 5069.4 5090.7 5097.3 5111.9 4944.7 4966.2 5021.1 5044.3 5050.3 5494.5 5551.4 5565.3 5577.8 5623.7 5679.3 5812.9 5939.6 5960.9 5962.2 5853.9 5890.3 5909.6 5924.4 5972.0 5455.4 5468.9 5469.6 5476.0 5481.5 5851.3 5996.5 6015.1 6027.5 6077.7 5834.2 5841.6 5844.9 5850.0 5876.0 5916.5 5919.7 5921.3 5924.3 5952.6 5665.3 5834.7 5861.1 5897.0 5903.8 5917.5 5921.0 5923.1 5930.4 5937.5 4451.1 4468.5 4495.3 4495.8 4555.0 3930.7 3932.1 3945.6 3955.0 4016.4 5518.1 5559.2 5568.1 5608.1 5629.5 5837.3 5965.3 5970.5 5975.2 5980.4 5470.2 5531.8 5550.4 5561.2 5588.9 5080.8 5093.3 5095.8 5099.9 5101.7 6104.8 6114.5 6119.2 6124.2 6125.0 5733.9 5848.9 5888.9 5932.8 5961.1 6110.9 6118.1 6121.8 6123.3 6126.9 5661.9 5807.2 5836.5 5843.4 5844.8 5872.3 5918.5 5944.1 5971.0 5987.3 5763.1 5798.8 5821.7 5821.8 5842.4 5653.3 5754.4 5790.1 5794.3 5815.4 5742.3 5781.9 5783.0 5789.4 5803.9 5713.9 5781.1 5854.1 5863.2 5883.7 5555.3 5687.4 5702.0 5731.3 5734.3 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#1] ext.html Cycles:180 Average:65609.63 Median:42996.86 stddev:134655.09 (313.2%) stddev-sans-first:134944.23 07:56:42 INFO - PROCESS | 4372 | Values: 550.7 584.7 591.1 594.6 619.9 39813.0 43675.0 43723.8 43793.9 43803.6 45065.5 45589.3 45794.3 45956.5 45966.0 8824.3 8866.0 8934.7 8970.3 8980.7 8669.9 8745.2 8783.8 8784.4 8792.3 8779.2 8822.0 8844.6 8853.8 8857.1 8678.7 8680.7 8782.3 8828.1 8845.6 8772.5 8858.7 8864.0 8867.9 8885.3 42501.4 42560.0 42605.8 42797.8 42823.4 3551.1 3597.2 3623.3 3707.5 3759.6 33511.0 34325.8 34450.0 34610.0 34884.0 4535.9 4538.5 4572.2 4609.4 4646.9 387302.0 388994.0 389630.0 389894.0 390237.0 63186.0 63586.0 63646.0 63689.4 63761.7 36384.1 37131.4 37148.4 38221.6 67392.7 17343.8 17455.7 17546.4 17581.2 17597.5 13458.8 13468.6 13514.6 13519.0 13584.0 20406.7 20462.8 20575.9 20586.2 20605.5 7032.9 7038.6 7237.6 7272.7 7275.5 967.5 1038.0 1091.7 1094.8 1204.1 34048.0 34111.7 34233.3 34312.8 34554.6 1110.6 1173.0 1200.6 1224.0 1233.9 17680.6 17958.5 17966.6 17983.6 17993.4 608661.0 610476.0 611746.0 613401.0 614555.0 62666.7 62837.7 63358.7 63496.7 63575.4 1281.8 1361.2 1375.3 1380.3 1381.6 31925.5 33326.8 33516.8 33555.7 33690.0 54274.5 54287.7 54424.0 54491.5 54568.5 489266.0 491426.0 492416.0 495839.0 496138.0 28304.6 28766.6 29516.6 29613.0 30268.4 47585.8 48416.5 50419.2 50700.5 51330.0 42569.0 43170.4 43257.0 44041.0 44910.1 42357.0 42387.8 43411.1 44158.1 44898.3 41921.0 42376.2 42428.0 42816.8 43513.0 38369.4 38773.4 38832.5 39595.8 39909.2 29287.9 29292.6 29417.3 29761.7 29802.7 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#2] jquery.html Cycles:180 Average:31043.51 Median:20495.49 stddev:90996.63 (444.0%) stddev-sans-first:91222.78 07:56:42 INFO - PROCESS | 4372 | Values: 385.2 386.4 393.5 401.3 410.2 14211.3 18869.9 19324.4 20260.0 20482.3 19059.3 19435.0 19588.8 19595.1 19813.7 5652.8 5693.1 5810.7 5829.6 5831.8 5627.1 5642.9 5739.3 5747.7 5755.3 5547.8 5641.5 5723.7 5734.7 5753.1 5634.5 5636.4 5643.6 5681.0 5716.9 4947.2 5254.5 5277.7 5324.4 5331.1 13794.4 13914.2 14365.6 14369.7 14413.9 2240.4 2378.8 2411.3 2573.5 2615.7 9968.9 10546.3 10560.0 12630.6 13920.2 1931.5 1934.6 1953.7 1972.5 1983.8 84845.6 88005.6 89249.6 90007.5 90434.5 11119.8 11198.7 11227.4 11414.1 11582.7 15649.5 15715.0 15757.1 15771.1 15876.6 7914.3 8002.4 8089.6 8166.6 8372.0 7815.5 7934.6 7979.5 8006.7 8016.8 4802.9 4828.9 4830.2 4843.2 4955.2 2001.2 2028.3 2048.6 2058.3 2098.7 953.3 1000.4 1004.4 1020.8 1047.6 19629.3 20077.6 20079.8 20372.2 20508.7 1038.1 1050.9 1051.9 1055.6 1078.8 10735.2 11203.3 11245.9 11255.2 11388.3 541321.0 552816.0 553944.0 554292.0 558864.0 83254.0 90274.0 92750.5 97680.5 101248.0 1025.9 1028.1 1060.4 1062.9 1065.5 17492.6 17686.1 18108.2 18257.3 18520.1 44881.6 45458.0 45467.8 45785.9 45791.5 62490.0 63303.4 63740.4 64160.7 64731.0 8340.1 8499.6 8607.2 8800.1 8899.2 11195.9 12395.4 12554.7 13414.7 13604.7 11144.2 11145.6 11360.4 11824.1 11829.1 10074.0 11835.1 11842.9 11901.2 12024.5 11866.3 11888.4 11916.9 12053.5 12088.9 7460.3 7613.7 7848.9 8045.8 8480.4 10940.0 11400.4 11487.9 11512.7 11653.7 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#3] mootools.html Cycles:180 Average:5799.84 Median:4629.35 stddev:3288.24 (71.0%) stddev-sans-first:3281.32 07:56:42 INFO - PROCESS | 4372 | Values: 1463.7 1494.1 1647.1 1789.4 1813.8 7630.2 8286.7 8459.1 8891.3 8905.3 8428.3 8735.9 8808.6 8813.0 8813.5 2333.4 2347.4 2363.4 2364.2 2376.8 2301.6 2315.7 2355.7 2381.7 2383.7 2327.0 2366.3 2374.9 2393.2 2396.2 2349.8 2365.6 2366.7 2378.1 2378.7 2312.2 2329.5 2329.9 2340.2 2345.4 8777.1 8801.7 8891.2 8891.3 8907.2 5077.9 5122.1 5175.1 5182.8 5193.1 3464.5 3474.0 3493.7 3545.1 3552.1 1262.7 1269.0 1271.3 1275.8 1299.3 12127.9 12163.0 12165.9 12221.3 12235.3 4382.9 4500.0 4615.4 4628.1 4697.5 10143.2 10151.2 10163.9 10171.3 10179.2 5294.6 5316.3 5316.6 5317.6 5325.9 4236.6 4630.6 4821.3 4824.0 4875.4 3786.5 3856.4 3961.3 3963.2 4007.8 1220.6 1230.6 1248.3 1249.6 1262.6 840.3 956.1 966.3 978.2 1005.2 5708.3 5795.6 5847.6 5926.1 5966.0 462.2 466.3 468.1 470.6 471.7 4211.1 4265.9 4268.9 4291.0 4303.0 10683.0 10909.9 10951.6 10959.5 10995.9 10224.5 10860.6 10868.3 10905.3 10942.3 7865.8 8070.6 8137.0 8149.2 8218.0 5985.7 6078.9 6145.9 6178.1 6320.1 9735.1 10131.2 10197.4 10236.3 10283.5 10301.7 10316.7 10358.9 10432.4 10432.9 7116.9 7714.4 7745.9 7833.2 7882.8 8571.5 8696.7 8702.3 8726.9 8821.7 7515.6 7734.6 7748.1 7770.4 7940.1 7705.2 7823.2 7826.3 7892.1 7904.3 7010.6 7022.2 7041.7 7051.9 7084.8 4841.0 5119.1 5231.5 5302.3 5306.9 5164.5 5224.6 5360.2 5424.4 5491.3 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#4] prototype.html Cycles:180 Average:4742.29 Median:5326.91 stddev:1380.88 (25.9%) stddev-sans-first:1344.16 07:56:42 INFO - PROCESS | 4372 | Values: 314.2 330.4 333.4 334.4 337.1 5477.3 5481.7 5664.3 5705.3 5714.1 5505.3 5524.9 5540.4 5541.1 5546.9 4365.9 4395.6 4404.8 4406.8 4425.6 4081.8 4270.7 4282.2 4415.7 4447.8 4232.8 4257.2 4263.4 4277.7 4294.8 4296.7 4298.2 4314.3 4316.3 4338.3 3578.4 3758.5 3768.0 3773.5 3781.5 5432.0 5471.4 5477.3 5486.2 5500.6 4898.6 4902.5 4905.9 4938.8 4960.2 5538.5 5828.6 5839.4 5858.8 5871.2 4157.8 4158.8 4183.3 4188.3 4202.6 6051.3 6093.1 6134.7 6161.3 6171.1 4168.7 4258.3 4266.9 4283.9 4289.2 4313.1 4314.7 4334.7 4359.2 4362.5 4959.3 4965.7 4965.8 4974.8 4991.2 5674.7 5821.4 5836.1 5948.1 5956.8 1454.6 1461.7 1463.3 1473.6 1478.1 907.8 926.3 933.4 936.4 951.1 4882.4 4912.6 4952.7 4975.0 4991.2 5252.7 5259.2 5331.0 5342.6 5397.7 4649.8 4949.5 4958.3 4984.0 4989.9 2815.5 2842.3 2875.6 2884.7 2885.0 5415.7 5470.1 5510.2 5510.8 5546.3 5196.9 5392.5 5403.8 5420.7 5423.0 5455.9 5463.7 5464.8 5474.6 5498.9 5098.4 5301.7 5316.7 5337.2 5386.4 5213.8 5242.9 5289.1 5314.2 5322.8 5491.9 5515.7 5599.8 5876.7 5955.8 4169.5 4176.9 4224.2 4229.8 4240.6 6015.8 6021.0 6023.3 6048.3 6058.2 5680.2 5828.9 5833.8 5835.9 5854.4 5777.9 5787.6 5793.6 5794.3 5804.2 5523.5 5736.9 5762.7 5808.7 5810.0 5929.3 5939.0 5945.2 5961.7 5979.7 5761.6 5824.3 5837.7 5854.6 5854.9 07:56:42 INFO - PROCESS | 4372 | 07:56:42 INFO - PROCESS | 4372 | [#5] yui.html Cycles:180 Average:20755.93 Median:4839.40 stddev:30168.50 (623.4%) stddev-sans-first:30215.58 07:56:42 INFO - PROCESS | 4372 | Values: 711.0 755.7 795.4 808.6 837.8 15930.8 16165.9 16284.5 16314.7 16368.1 14769.6 14920.1 14927.6 14933.7 14975.5 662.8 790.6 797.2 801.4 812.0 808.7 810.6 811.7 812.5 814.3 871.2 874.2 877.9 880.6 881.8 872.4 875.6 878.3 878.6 878.7 634.5 635.8 640.2 641.6 643.9 14888.6 14960.9 14994.9 15003.3 15008.3 15541.2 15595.2 15934.7 16128.3 16417.3 12532.9 12599.6 12727.8 12827.4 12915.9 3907.1 3944.9 3982.3 4001.5 4151.0 74311.6 76287.0 76708.0 78327.2 79581.2 12149.5 12201.4 12318.9 12408.9 12459.8 23138.5 23156.7 23188.5 23193.3 23210.2 8879.2 8880.1 8940.2 9077.9 9306.8 4865.8 4980.8 5041.5 5056.3 5093.0 3592.0 3678.0 3705.2 3709.6 3710.6 651.0 652.9 663.9 664.2 668.9 581.6 695.6 700.3 716.2 724.4 9377.9 9496.6 9560.8 9910.7 9984.3 634.8 699.6 704.5 705.6 706.2 4771.4 4838.2 4840.6 4891.1 4923.5 99079.0 114988.0 117416.0 117673.0 121849.0 103408.0 104046.5 104626.0 106444.5 107389.5 53048.9 55348.7 56122.4 93335.0 93872.5 8733.3 8890.4 9015.4 9130.0 9157.8 55237.7 55472.4 56255.7 57048.4 57396.0 77705.8 79785.6 79932.0 80582.0 81492.2 10974.2 11227.7 11262.7 11341.0 11695.6 12215.6 12625.4 13005.5 13043.9 13117.7 11890.3 12009.2 12065.7 12118.2 12362.9 12123.3 12185.3 12328.9 12529.7 12623.9 12241.7 12254.4 12321.6 12592.5 12802.9 10269.7 10696.3 10780.1 10794.0 10822.8 10193.3 10245.1 10395.8 10445.8 10611.6 07:56:42 INFO - PROCESS | 4372 | -------- Summary: end -------- 07:56:42 INFO - PROCESS | 4372 | 07:56:43 INFO - TEST-INFO | 4372: exit 0 07:56:43 INFO - TEST-OK | dromaeo_css | took 1110441ms 07:56:43 INFO - TEST-START | kraken 07:56:43 INFO - operating with platform_type : linux_ 07:56:43 INFO - Initialising browser for kraken test... 07:56:43 INFO - TEST-INFO | started process 4621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV1yQI7/profile http://localhost:40884/getInfo.html) 07:56:48 INFO - PROCESS | 4621 | __metrics Screen width/height:1600/1200 07:56:48 INFO - PROCESS | 4621 | colorDepth:24 07:56:48 INFO - PROCESS | 4621 | Browser inner width/height: 1024/697 07:56:48 INFO - PROCESS | 4621 | __metrics 07:56:48 ERROR - PROCESS | 4621 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:56:49 INFO - TEST-INFO | 4621: exit 0 07:56:49 INFO - Browser initialized. 07:56:49 INFO - Running cycle 1/1 for kraken test... 07:56:49 INFO - TEST-INFO | started process 4741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV1yQI7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:01 INFO - PROCESS | 4741 | RSS: Main: 167178240 07:57:01 INFO - PROCESS | 4741 | 07:57:04 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40884/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:05 INFO - PROCESS | 4741 | RSS: Main: 172515328 07:57:05 INFO - PROCESS | 4741 | 07:57:07 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40884/tests/kraken/driver.html?testName=audio-dft) 07:57:08 INFO - PROCESS | 4741 | RSS: Main: 171974656 07:57:08 INFO - PROCESS | 4741 | 07:57:11 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40884/tests/kraken/driver.html?testName=audio-fft) 07:57:11 INFO - PROCESS | 4741 | RSS: Main: 167198720 07:57:11 INFO - PROCESS | 4741 | 07:57:13 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40884/tests/kraken/driver.html?testName=audio-oscillator) 07:57:14 INFO - PROCESS | 4741 | RSS: Main: 168034304 07:57:14 INFO - PROCESS | 4741 | 07:57:16 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:17 INFO - PROCESS | 4741 | RSS: Main: 168271872 07:57:17 INFO - PROCESS | 4741 | 07:57:20 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40884/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:21 INFO - PROCESS | 4741 | RSS: Main: 168050688 07:57:21 INFO - PROCESS | 4741 | 07:57:24 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40884/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:25 INFO - PROCESS | 4741 | RSS: Main: 169046016 07:57:25 INFO - PROCESS | 4741 | 07:57:28 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40884/tests/kraken/driver.html?testName=json-parse-financial) 07:57:28 INFO - PROCESS | 4741 | RSS: Main: 168910848 07:57:28 INFO - PROCESS | 4741 | 07:57:30 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:30 INFO - PROCESS | 4741 | RSS: Main: 168611840 07:57:30 INFO - PROCESS | 4741 | 07:57:32 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:33 INFO - PROCESS | 4741 | RSS: Main: 168988672 07:57:33 INFO - PROCESS | 4741 | 07:57:35 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:36 INFO - PROCESS | 4741 | RSS: Main: 169533440 07:57:36 INFO - PROCESS | 4741 | 07:57:38 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:39 INFO - PROCESS | 4741 | RSS: Main: 169996288 07:57:39 INFO - PROCESS | 4741 | 07:57:41 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:42 INFO - PROCESS | 4741 | RSS: Main: 169451520 07:57:42 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | Cycle 1(1): loaded http://localhost:40884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40884/tests/kraken/driver.html?testName=ai-astar) 07:57:44 INFO - PROCESS | 4741 | RSS: Main: 170098688 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | __start_tp_report 07:57:44 INFO - PROCESS | 4741 | _x_x_mozilla_page_load 07:57:44 INFO - PROCESS | 4741 | _x_x_mozilla_page_load_details 07:57:44 INFO - PROCESS | 4741 | |i|pagename|runs| 07:57:44 INFO - PROCESS | 4741 | |0;ai-astar;103;112;106;111;113;114;115;110;111;112 07:57:44 INFO - PROCESS | 4741 | |1;audio-beat-detection;147;117;145;173;119;162;151;118;174;117 07:57:44 INFO - PROCESS | 4741 | |2;audio-dft;163;164;162;160;163;164;168;163;161;161 07:57:44 INFO - PROCESS | 4741 | |3;audio-fft;76;76;76;141;77;77;82;75;183;76 07:57:44 INFO - PROCESS | 4741 | |4;audio-oscillator;84;83;155;85;84;83;156;84;84;144 07:57:44 INFO - PROCESS | 4741 | |5;imaging-gaussian-blur;117;118;118;117;117;117;118;119;118;117 07:57:44 INFO - PROCESS | 4741 | |6;imaging-darkroom;147;149;147;147;151;147;148;147;148;147 07:57:44 INFO - PROCESS | 4741 | |7;imaging-desaturate;95;97;96;96;96;96;95;96;96;95 07:57:44 INFO - PROCESS | 4741 | |8;json-parse-financial;53;55;53;56;54;54;55;53;53;55 07:57:44 INFO - PROCESS | 4741 | |9;json-stringify-tinderbox;62;63;63;63;63;62;62;63;65;63 07:57:44 INFO - PROCESS | 4741 | |10;stanford-crypto-aes;77;77;79;76;75;84;76;77;81;76 07:57:44 INFO - PROCESS | 4741 | |11;stanford-crypto-ccm;121;118;129;120;122;126;124;123;177;121 07:57:44 INFO - PROCESS | 4741 | |12;stanford-crypto-pbkdf2;157;162;160;154;157;156;160;160;161;155 07:57:44 INFO - PROCESS | 4741 | |13;stanford-crypto-sha256-iterative;65;66;63;62;66;69;64;65;63;61 07:57:44 INFO - PROCESS | 4741 | __end_tp_report 07:57:44 INFO - PROCESS | 4741 | __start_cc_report 07:57:44 INFO - PROCESS | 4741 | _x_x_mozilla_cycle_collect,922 07:57:44 INFO - PROCESS | 4741 | __end_cc_report 07:57:44 INFO - PROCESS | 4741 | __startTimestamp1468594664438__endTimestamp 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | ------- Summary: start ------- 07:57:44 INFO - PROCESS | 4741 | Number of tests: 14 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.65 (3.3%) stddev-sans-first:2.60 07:57:44 INFO - PROCESS | 4741 | Values: 103.0 112.0 106.0 111.0 113.0 114.0 115.0 110.0 111.0 112.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.00 stddev:23.22 (15.6%) stddev-sans-first:24.57 07:57:44 INFO - PROCESS | 4741 | Values: 147.0 117.0 145.0 173.0 119.0 162.0 151.0 118.0 174.0 117.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.23 (1.4%) stddev-sans-first:2.37 07:57:44 INFO - PROCESS | 4741 | Values: 163.0 164.0 162.0 160.0 163.0 164.0 168.0 163.0 161.0 161.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.28 (49.1%) stddev-sans-first:38.98 07:57:44 INFO - PROCESS | 4741 | Values: 76.0 76.0 76.0 141.0 77.0 77.0 82.0 75.0 183.0 76.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:84.00 stddev:32.91 (39.2%) stddev-sans-first:34.08 07:57:44 INFO - PROCESS | 4741 | Values: 84.0 83.0 155.0 85.0 84.0 83.0 156.0 84.0 84.0 144.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 07:57:44 INFO - PROCESS | 4741 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 118.0 119.0 118.0 117.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.32 (0.9%) stddev-sans-first:1.36 07:57:44 INFO - PROCESS | 4741 | Values: 147.0 149.0 147.0 147.0 151.0 147.0 148.0 147.0 148.0 147.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 07:57:44 INFO - PROCESS | 4741 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.10 (2.0%) stddev-sans-first:1.09 07:57:44 INFO - PROCESS | 4741 | Values: 53.0 55.0 53.0 56.0 54.0 54.0 55.0 53.0 53.0 55.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 07:57:44 INFO - PROCESS | 4741 | Values: 62.0 63.0 63.0 63.0 63.0 62.0 62.0 63.0 65.0 63.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.00 stddev:2.78 (3.6%) stddev-sans-first:2.93 07:57:44 INFO - PROCESS | 4741 | Values: 77.0 77.0 79.0 76.0 75.0 84.0 76.0 77.0 81.0 76.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:123.50 stddev:17.46 (14.1%) stddev-sans-first:18.33 07:57:44 INFO - PROCESS | 4741 | Values: 121.0 118.0 129.0 120.0 122.0 126.0 124.0 123.0 177.0 121.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:160.00 stddev:2.74 (1.7%) stddev-sans-first:2.87 07:57:44 INFO - PROCESS | 4741 | Values: 157.0 162.0 160.0 154.0 157.0 156.0 160.0 160.0 161.0 155.0 07:57:44 INFO - PROCESS | 4741 | 07:57:44 INFO - PROCESS | 4741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:2.32 (3.6%) stddev-sans-first:2.45 07:57:44 INFO - PROCESS | 4741 | Values: 65.0 66.0 63.0 62.0 66.0 69.0 64.0 65.0 63.0 61.0 07:57:44 INFO - PROCESS | 4741 | -------- Summary: end -------- 07:57:44 INFO - PROCESS | 4741 | 07:57:45 INFO - TEST-INFO | 4741: exit 0 07:57:45 INFO - TEST-OK | kraken | took 61944ms 07:57:45 INFO - SUITE-END | took 1172s 07:57:45 INFO - Completed test suite (00:19:32) 07:57:45 INFO - javascript benchmark 07:57:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.640224416294, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.923276918077, 3130.2174456385887, 3142.261568531395, 3162.114607909786, 3175.079227024163, 5512.0, 5529.225908372831, 5561.9721901390485, 5635.21107045014, 5637.943620563803, 5395.514403703666, 5470.863228419282, 5522.972385138079, 5542.528885044766, 5553.111502159645, 4975.502449755032, 4999.375078115236, 5090.567301779353, 5136.58907287418, 5189.506996835314, 641.1520656356117, 4895.951040489603, 4975.104481193383, 5021.17150670139, 5063.46833582474, 5014.2979982802435, 5024.371953505812, 5045.293658887758, 5058.038972595214, 5060.645754797166, 5065.392152941634, 5069.366329208849, 5090.694558326512, 5097.286379906779, 5111.897762044739, 4944.653874228806, 4966.230234313687, 5021.096202683516, 5044.268581055726, 5050.2929589857085, 5494.450554944514, 5551.3893471718075, 5565.332160140809, 5577.832665020056, 5623.746931388097, 5679.261695979538, 5812.941870581282, 5939.554533409968, 5960.880782384372, 5962.2249107615735, 5853.941460585383, 5890.293164820207, 5909.556783241274, 5924.407559244084, 5972.044472884318, 5455.372632147314, 5468.91796623051, 5469.56243500519, 5476.041692703761, 5481.5340696040885, 5851.297844258716, 5996.4603185713495, 6015.0977353396465, 6027.547933904974, 6077.696115194222, 5834.154047663065, 5841.591088623755, 5844.912326315109, 5849.970750146222, 5875.970620146872, 5916.526677865761, 5919.704014799329, 5921.3190483094995, 5924.318703349084, 5952.553558483131, 5665.263515742927, 5834.737436815353, 5861.120831875168, 5897.0, 5903.822885313448, 5917.467427931507, 5921.0, 5923.111533269957, 5930.436608522184, 5937.465628093492, 4451.06527629195, 4468.4637843458995, 4495.325701144789, 4495.842645507457, 4555.0, 3930.7051971102283, 3932.05630648648, 3945.6251656092627, 3955.011247188203, 4016.357382818735, 5518.144687573433, 5559.16612508127, 5568.109102543654, 5608.10270356741, 5629.521490673339, 5837.328707198726, 5965.343812180743, 5970.492508136857, 5975.223220981332, 5980.43185897339, 5470.206820011155, 5531.778728850882, 5550.417206193372, 5561.193626924073, 5588.86027849307, 5080.796768129233, 5093.337866077386, 5095.77069031887, 5099.923501147486, 5101.69389836611, 6104.847378815476, 6114.48026917717, 6119.173911521976, 6124.234470691164, 6124.989376752875, 5733.913991290134, 5848.853778655568, 5888.882222355443, 5932.79235226765, 5961.135635332939, 6110.938890611037, 6118.143459915526, 6121.816345509642, 6123.2652081750475, 6126.877462450815, 5661.943380566142, 5807.186993820784, 5836.533077353716, 5843.415658434123, 5844.824655260349, 5872.265966754156, 5918.496927761188, 5944.138099975393, 5971.044632858721, 5987.31145918225, 5763.077907534775, 5798.82603521895, 5821.650700957956, 5821.825345239649, 5842.38654941225, 5653.3498647654405, 5754.424557544212, 5790.10253410722, 5794.333651630117, 5815.3893841147765, 5742.339630942495, 5781.94218057814, 5783.0, 5789.363170051375, 5803.912941305968, 5713.885722285614, 5781.075027995501, 5854.121881717776, 5863.20846685692, 5883.705814709333, 5555.333359996826, 5687.374388817309, 5702.0, 5731.254936858182, 5734.283214598176], "value": 5410.830659218128, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6808715529855, 584.7310237290847, 591.0897218283843, 594.5511139089987, 619.9039148931918, 39813.0, 43675.0, 43723.78138109313, 43793.90515237117, 43803.561964380344, 45065.549344506544, 45589.31616025754, 45794.313085303744, 45956.54043459564, 45966.0, 8824.338174636896, 8866.0, 8934.731958041237, 8970.327225458117, 8980.685676001342, 8669.869951950726, 8745.212930836224, 8783.78040548985, 8784.429012114193, 8792.296616270683, 8779.2098711116, 8821.955890220572, 8844.601992910302, 8853.778655533599, 8857.070007649201, 8678.696245631405, 8680.739577812676, 8782.25350845179, 8828.07305232951, 8845.646174153026, 8772.473651580925, 8858.73423797287, 8864.0, 8867.911320886773, 8885.333599980027, 42501.362479562835, 42560.0, 42605.78697106526, 42797.78601107006, 42823.35764963528, 3551.1122219445137, 3597.244578638489, 3623.2934577757346, 3707.480952666629, 3759.6240375962457, 33511.0, 34325.828370857984, 34450.0, 34610.0, 34884.0, 4535.931961020588, 4538.52345503724, 4572.154151481986, 4609.446866376023, 4646.86059418218, 387302.0, 388994.0, 389630.0, 389894.0, 390237.0, 63186.0, 63586.0, 63646.0, 63689.36310636927, 63761.68119159374, 36384.09039773974, 37131.443028354595, 37148.44277335788, 38221.61778382236, 67392.6630366845, 17343.826561734473, 17455.65088698219, 17546.38587649426, 17581.208845601977, 17597.472075837744, 13458.798118028237, 13468.595942121752, 13514.59456216315, 13519.0, 13584.0, 20406.69389959152, 20462.79537204609, 20575.897120514303, 20586.176552938014, 20605.48486287825, 7032.8945065824055, 7038.612876291751, 7237.62485127824, 7272.672759707965, 7275.454340924452, 967.5114067396061, 1038.0449986012886, 1091.6670415523183, 1094.7810437912449, 1204.145057009533, 34048.0, 34111.65888341134, 34233.31533369319, 34312.828435857664, 34554.6415165444, 1110.640313053005, 1172.9530818767325, 1200.5737963023175, 1223.9877601224052, 1233.8951189148843, 17680.646387072185, 17958.461246162635, 17966.640667186846, 17983.64032719338, 17993.370232041816, 608661.0, 610476.0, 611746.0, 613401.0, 614555.0, 62666.68666656638, 62837.685811571566, 63358.68320658367, 63496.68251658712, 63575.36424635694, 1281.833361662978, 1361.2241022617013, 1375.3329635126756, 1380.2615600653603, 1381.5855243426931, 31925.521117182798, 33326.83336583398, 33516.82691105799, 33555.66444335623, 33690.0, 54274.45725542694, 54287.72856135694, 54424.0, 54491.45508544864, 54568.45431545792, 489266.0, 491426.0, 492416.0, 495839.0, 496138.0, 28304.575431368135, 28766.568501472913, 29516.557251640814, 29613.0, 30268.394632106792, 47585.81035474141, 48416.5158348412, 50419.243711343624, 50700.49299506958, 51330.0, 42569.0, 43170.352444713986, 43257.0, 44041.0, 44910.10179796451, 42357.0, 42387.788061059495, 43411.131777364906, 44158.11683766371, 44898.3265251015, 41921.0, 42376.15247694967, 42428.0, 42816.78591607022, 43513.0, 38369.42445863259, 38773.41839872461, 38832.53425856063, 39595.80202098971, 39909.2018159641, 29287.853560732914, 29292.56061159127, 29417.264568385963, 29761.702382975895, 29802.701972979994], "value": 20799.045752565005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2180074448866, 386.35285896123986, 393.50221969208957, 401.2516656435747, 410.2205808962972, 14211.289435528208, 18869.905650471745, 19324.420267391964, 20260.0, 20482.2831200908, 19059.332923347687, 19435.0, 19588.804111958878, 19595.118219680113, 19813.702794458095, 5652.830415087554, 5693.089105743082, 5810.680412577307, 5829.621074630157, 5831.825045248649, 5627.071533197018, 5642.943570564304, 5739.3399759027825, 5747.712614369286, 5755.25181726375, 5547.750351234184, 5641.492265696086, 5723.656580605177, 5734.713264336767, 5753.079507278836, 5634.4928956393915, 5636.379998200195, 5643.6049476536655, 5681.034224181878, 5716.942830571704, 4947.183714687072, 5254.474552544753, 5277.7361131943635, 5324.361076670824, 5331.120365139747, 13794.448222071105, 13914.165150091027, 14365.569032929028, 14369.71260574793, 14413.927930360282, 2240.406292332533, 2378.7996103604096, 2411.276617014906, 2573.4853029394008, 2615.6599642046604, 9968.850467242997, 10546.314489558154, 10560.0, 12630.621081367573, 13920.164790112525, 1931.5364312565023, 1934.5937353155714, 1953.7007889753297, 1972.5265936175358, 1983.7917018712972, 84845.57577212075, 88005.55997219973, 89249.55375223083, 90007.54996225043, 90434.54782726044, 11119.777604447865, 11198.720031999264, 11227.438628068563, 11414.086873050135, 11582.710432239093, 15649.530514084596, 15715.0, 15757.054576725204, 15771.05373677583, 15876.60308492297, 7914.327282180964, 8002.3598112150885, 8089.635966381527, 8166.550839703755, 8372.0, 7815.53106813593, 7934.563599001995, 7979.521228726295, 8006.71976480832, 8016.839663206703, 4802.855914322576, 4828.879278018007, 4830.178869592178, 4843.200871856105, 4955.1823949048, 2001.1995201919349, 2028.2900984655253, 2048.5902819436174, 2058.259026750369, 2098.6642137257963, 953.3326671330096, 1000.3947611694965, 1004.4124187350336, 1020.7703266764919, 1047.5914393386586, 19629.331506821796, 20077.598448030956, 20079.799202008086, 20372.185112595627, 20508.69236961447, 1038.1020417338948, 1050.9421981791074, 1051.9316244444087, 1055.6041484443333, 1078.7950289445137, 10735.248532602798, 11203.271787333797, 11245.94377028126, 11255.155863310285, 11388.259763115371, 541321.0, 552816.0, 553944.0, 554292.0, 558864.0, 83254.0, 90274.0, 92750.53624731833, 97680.51159744155, 101248.0, 1025.933314334566, 1028.0798685176874, 1060.4326685223368, 1062.8786630105312, 1065.4938904020682, 17492.562685932953, 17686.11569421498, 18108.185131668844, 18257.269709211483, 18520.0739963004, 44881.55118448774, 45458.0, 45467.772661136485, 45785.855353616425, 45791.54208457873, 62490.0, 63303.36696633159, 63740.3625963753, 64160.67919660372, 64731.0, 8340.124286949784, 8499.575021249037, 8607.18231767981, 8800.075992020746, 8899.199072083544, 11195.944020279847, 12395.442205100973, 12554.748905021666, 13414.664633384244, 13604.727905441638, 11144.164187685794, 11145.554177832795, 11360.375179365214, 11824.1131915105, 11829.112816538965, 10074.0, 11835.11236657237, 11842.940785296363, 11901.226420282654, 12024.519019239133, 11866.347350895783, 11888.405579720806, 11916.880831191924, 12053.457594408097, 12088.879111208775, 7460.29127232912, 7613.695452182073, 7848.882266765889, 8045.758627241192, 8480.363972701949, 10940.0, 11400.372979486208, 11487.94256028748, 11512.654620361403, 11653.708657283296], "value": 9270.189746221378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.7292100961322, 1494.140869000325, 1647.1270226779804, 1789.3737191982816, 1813.791413987391, 7630.236976302367, 8286.709965151222, 8459.111793261696, 8891.333150013743, 8905.287576993842, 8428.283595894341, 8735.91264087359, 8808.603612837422, 8812.955935220314, 8813.471191728484, 2333.4283100640323, 2347.424880904181, 2363.3500787283547, 2364.196173301077, 2376.7504412036747, 2301.5972204864083, 2315.710536182977, 2355.7290911545133, 2381.6784734060852, 2383.678203442539, 2326.9534609307802, 2366.325597204797, 2374.881255937205, 2393.2102406205995, 2396.1733202045266, 2349.81201503881, 2365.5978483657645, 2366.668666386707, 2378.0963233971065, 2378.6907701998716, 2312.17917639239, 2329.5340931813703, 2329.883505824719, 2340.157543284416, 2345.413646588353, 8777.078406767261, 8801.735947921572, 8891.19979201875, 8891.33315001371, 8907.198352148338, 5077.923831142499, 5122.129238029544, 5175.068487672217, 5182.766775495112, 5193.065248255312, 3464.497647841074, 3473.9652603473896, 3493.7205023598303, 3545.0782796472845, 3552.1119720069983, 1262.652770488114, 1268.987310126896, 1271.3452571925466, 1275.8086287057015, 1299.2529295654942, 12127.939360303142, 12163.0, 12165.878341216563, 12221.266723996589, 12235.265884046985, 4382.912341753211, 4499.955000449953, 4615.446146462446, 4628.097520983443, 4697.4832768395445, 10143.239257055602, 10151.187904967584, 10163.898361016443, 10171.338862973884, 10179.185665146919, 5294.602904782157, 5316.255724198615, 5316.627836051517, 5317.574594032468, 5325.8934821303355, 4236.597523235288, 4630.6063984561015, 4821.276808478686, 4823.9517604824205, 4875.43932447773, 3786.5077539919635, 3856.3636999895266, 3961.267165574378, 3963.1677347757295, 4007.8196481158416, 1220.5850010996303, 1230.6492649594823, 1248.2822377133184, 1249.575144450891, 1262.5959692898184, 840.2521755637488, 956.086936975187, 966.2897770138942, 978.2223132609593, 1005.2360206243162, 5708.257926469615, 5795.594308398456, 5847.649141051551, 5926.081457374114, 5965.985782416999, 462.17732436263503, 466.3424571354374, 468.08255818595256, 470.6187987729881, 471.7381005809446, 4211.136716973013, 4265.912192390921, 4268.935965960513, 4290.978545107317, 4302.978485107555, 10683.0, 10909.890901090888, 10951.56193752241, 10959.50682219302, 10995.890041099647, 10224.488775561193, 10860.619878304222, 10868.347899126078, 10905.34567925927, 10942.343459392461, 7865.842683146419, 8070.556119413372, 8136.959315203386, 8149.225823546753, 8218.013838339437, 5985.730642121028, 6078.90881636767, 6145.938540614716, 6178.104174894705, 6320.083587879823, 9735.123838854537, 10131.240156988108, 10197.439140847027, 10236.33463824849, 10283.485825708834, 10301.74245643865, 10316.690499285034, 10358.896411036094, 10432.374057556268, 10432.895671043496, 7116.857662846817, 7714.421418393531, 7745.922540774745, 7833.1775163607, 7882.84234315299, 8571.528565928933, 8696.739097827076, 8702.347323950602, 8726.869096963677, 8821.691240806542, 7515.586642734484, 7734.613269336398, 7748.108967468813, 7770.417218708732, 7940.126586075643, 7705.190954949874, 7823.217678232131, 7826.334761545332, 7892.0529536456, 7904.328132108835, 7010.579365238102, 7022.192447868356, 7041.718331266692, 7051.929480705127, 7084.787456376317, 4841.031793641216, 5119.078565858182, 5231.4768523148905, 5302.310699609026, 5306.9203961941375, 5164.457731938242, 5224.60815438836, 5360.212222674735, 5424.430434804289, 5491.28613280287], "value": 4586.142767748998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2458100558659, 330.43825496655677, 333.4065363652696, 334.3530268929621, 337.13188539510764, 5477.315335583052, 5481.671099734019, 5664.348599911012, 5705.315362156542, 5714.114312281597, 5505.284313039299, 5524.917126243109, 5540.445955404458, 5541.085720856054, 5546.944530554693, 4365.934510982338, 4395.626371758404, 4404.845830395929, 4406.779661016953, 4425.579569940851, 4081.755034730901, 4270.743755374688, 4282.164977829325, 4415.67529741078, 4447.799849006787, 4232.830686772525, 4257.191133684605, 4263.445752052245, 4277.74333539987, 4294.849680261192, 4296.677749168824, 4298.204832106055, 4314.266574682311, 4316.309390497537, 4338.262495375794, 3578.4095624221973, 3758.455024021529, 3767.9623203767887, 3773.5471743390694, 3781.546214454283, 5432.0, 5471.398146203915, 5477.315335583052, 5486.177073438977, 5500.559955203574, 4898.632602554822, 4902.4852390498845, 4905.8773530661665, 4938.753062346904, 4960.1567733485035, 5538.479991603811, 5828.562857785683, 5839.445252700986, 5858.76564937402, 5871.236739223874, 4157.833686652531, 4158.8336466541305, 4183.330667093281, 4188.308929026707, 4202.621764041251, 6051.334353221142, 6093.086037094427, 6134.723937422782, 6161.260648722137, 6171.086963041426, 4168.749875007509, 4258.339957306623, 4266.914661706811, 4283.87148385549, 4289.206496798102, 4313.094250207429, 4314.676399270004, 4334.718243314174, 4359.215341238608, 4362.520122786491, 4959.330490383824, 4965.726885021286, 4965.826196083192, 4974.801007959641, 4991.151504244214, 5674.659520428705, 5821.388754180834, 5836.124581312837, 5948.137520059654, 5956.761729530857, 1454.5854431487187, 1461.663817322022, 1463.2610531681432, 1473.5873955292536, 1478.0909740509724, 907.841127802632, 926.282131348197, 933.421278807144, 936.3679516326453, 951.1297163095828, 4882.389701287339, 4912.606991440676, 4952.727599981963, 4974.980129073531, 4991.226359914219, 5252.737363131828, 5259.15853463444, 5330.973345133327, 5342.572594192456, 5397.73011349431, 4649.814007439664, 4949.461135288286, 4958.330625365602, 4983.975080124576, 4989.900201996013, 2815.47913635978, 2842.3178437175343, 2875.611792407998, 2884.6586337353233, 2884.9614138909974, 5415.729213539307, 5470.140152348221, 5510.201020852034, 5510.752016159283, 5546.251256080458, 5196.934628401169, 5392.4948783291175, 5403.83788486346, 5420.728963551806, 5423.0, 5455.945440545624, 5463.672179669233, 5464.753836317101, 5474.576610081328, 5498.927709096768, 5098.439171691037, 5301.6818990860675, 5316.680999140064, 5337.199420087018, 5386.380566234933, 5213.843584692465, 5242.921356179737, 5289.143862314308, 5314.202869569441, 5322.840314790563, 5491.917621235764, 5515.669059856422, 5599.776008959596, 5876.676782776988, 5955.821325360246, 4169.478815148106, 4176.9164616706885, 4224.218519573888, 4229.788510574521, 4240.597143271384, 6015.796840631979, 6021.0, 6023.27720673522, 6048.304444988883, 6058.242719660043, 5680.2107336188965, 5828.912566311424, 5833.79581714638, 5835.94164058371, 5854.443827836349, 5777.942220577908, 5787.56593255516, 5793.594448388572, 5794.333651630117, 5804.1874137619925, 5523.475269849358, 5736.856578585402, 5762.732198916232, 5808.651480911159, 5809.970950145223, 5929.347771745191, 5939.0, 5945.227120474311, 5961.701914904151, 5979.701014949323, 5761.56788240892, 5824.271966004249, 5837.737301821343, 5854.619449735754, 5854.9121763174435], "value": 4297.14915546173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9608971506568, 755.7241606813513, 795.3915254830052, 808.6037841457686, 837.8408102460528, 15930.761038584416, 16165.919170404131, 16284.511464656065, 16314.673706525862, 16368.099754513498, 14769.556913292592, 14920.104793712384, 14927.552173434788, 14933.701325973474, 14975.47585834496, 662.8011596521036, 790.5849429049766, 797.1629788721848, 801.4349883332237, 811.9797005074861, 808.7169490678274, 810.6149578949982, 811.6591031766673, 812.5124925044985, 814.2549567146054, 871.2028493928049, 874.1608056265992, 877.9473231606124, 880.55972013993, 881.8456770065245, 872.4372779557182, 875.5972252763736, 878.3061381508601, 878.6002368922188, 878.6836738774068, 634.4987459906669, 635.8442181665475, 640.2381166411955, 641.5637366590717, 643.893757530007, 14888.553343399715, 14960.850391496164, 14994.850051499563, 15003.32485038165, 15008.324625391884, 15541.222938853125, 15595.152536492258, 15934.681306373808, 16128.274227659784, 16417.343306267736, 12532.937335313356, 12599.559015434415, 12727.809082863765, 12827.422765975554, 12915.87084129156, 3907.1404291056206, 3944.861929832442, 3982.283189025974, 4001.4998125234347, 4151.0, 74311.62844185799, 76287.0, 76708.0, 78327.21672783257, 79581.20418795796, 12149.453274602663, 12201.38993050344, 12318.938405307916, 12408.937955310166, 12459.750804983849, 23138.537229255657, 23156.65265021026, 23188.53622927532, 23193.304200874, 23210.1876434324, 8879.200871921557, 8880.111988801069, 8940.240079593177, 9077.909220907839, 9306.813863722688, 4865.829695960624, 4980.7509624518625, 5041.495850415003, 5056.317397151411, 5093.0, 3591.964080359215, 3677.9701683528656, 3705.184859330943, 3709.629037096269, 3710.6289371063217, 650.9804705858832, 652.9085927970089, 663.8705452436728, 664.1565212180503, 668.9498287628447, 581.5522048023083, 695.6000299827518, 700.3276854220006, 716.1799739298474, 724.3589423360364, 9377.859332110023, 9496.572654230577, 9560.808783824423, 9910.702678919644, 9984.301098923006, 634.7810005548079, 699.6152116335995, 704.520925770481, 705.6048612776862, 706.1914108345915, 4771.379720636364, 4838.201696720002, 4840.588549973291, 4891.144049791273, 4923.48303428142, 99079.0, 114988.0, 117416.0, 117673.0, 121849.0, 103408.0, 104046.47976760218, 104626.0, 106444.46777766061, 107389.46305268424, 53048.93902121936, 55348.72325638426, 56122.438775612536, 93335.0, 93872.49020078377, 8733.257673097858, 8890.377673563047, 9015.413998090366, 9129.954350228207, 9157.771055723393, 55237.72381138069, 55472.44527554673, 56255.71872140777, 57048.42951570431, 57395.99999999833, 77705.83441248273, 79785.60107199427, 79932.0, 80582.0, 81492.18507815083, 10974.176936729618, 11227.663170104583, 11262.718432039264, 11341.036011938748, 11695.649130526097, 12215.633530994084, 12625.431855566705, 13005.544805931748, 13043.934780326417, 13117.672058198621, 11890.34603096838, 12009.159358845147, 12065.698357541132, 12118.151729378858, 12362.938185309016, 12123.333216673167, 12185.329806860707, 12328.876711233132, 12529.686757831127, 12623.873761262637, 12241.693957650774, 12254.387280635754, 12321.568745093879, 12592.496300148257, 12802.871971280541, 10269.74325641865, 10696.304740191863, 10780.137588992706, 10794.0, 10822.783544328911, 10193.337433066827, 10245.077942985166, 10395.792084158425, 10445.843312350473, 10611.628592999208], "value": 7540.951504116606, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 106.0, 111.0, 113.0, 114.0, 115.0, 110.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 145.0, 173.0, 119.0, 162.0, 151.0, 118.0, 174.0, 117.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 160.0, 163.0, 164.0, 168.0, 163.0, 161.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 141.0, 77.0, 77.0, 82.0, 75.0, 183.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 155.0, 85.0, 84.0, 83.0, 156.0, 84.0, 84.0, 144.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 151.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 56.0, 54.0, 54.0, 55.0, 53.0, 53.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 65.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 76.0, 75.0, 84.0, 76.0, 77.0, 81.0, 76.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 129.0, 120.0, 122.0, 126.0, 124.0, 123.0, 177.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 162.0, 160.0, 154.0, 157.0, 156.0, 160.0, 160.0, 161.0, 155.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 63.0, 62.0, 66.0, 69.0, 64.0, 65.0, 63.0, 61.0], "value": 64.4, "unit": "score"}]}]} 07:57:45 INFO - Return code: 0 07:57:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:45 ERROR - # TBPL SUCCESS # 07:57:45 INFO - Running post-action listener: _resource_record_post_action 07:57:45 INFO - ##### 07:57:45 INFO - ##### Finished run-tests step (success) 07:57:45 INFO - ##### 07:57:45 INFO - Running post-run listener: _resource_record_post_run 07:57:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 139264; Write bytes: 306122752; Read time: 36; Write time: 344516 07:57:45 INFO - TinderboxPrint: CPU usage
13.4% 07:57:45 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 36 07:57:45 INFO - TinderboxPrint: I/O write bytes / time
306,122,752 / 344,516 07:57:45 INFO - TinderboxPrint: CPU idle
8,226.3 (86.6%) 07:57:45 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 07:57:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13910016; Read time: 0; Write time: 3720 07:57:45 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 135168; Write bytes: 292212736; Read time: 28; Write time: 340796 07:57:46 INFO - Running post-run listener: _upload_blobber_files 07:57:46 INFO - Blob upload gear active. 07:57:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:46 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 07:57:46 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:57:46 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:57:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:47 INFO - (blobuploader) - INFO - Done attempting. 07:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:51 INFO - (blobuploader) - INFO - Done attempting. 07:57:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:57:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:57:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:52 INFO - (blobuploader) - INFO - Done attempting. 07:57:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:52 INFO - Return code: 0 07:57:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9c884ae838e5a66f1af73adb28295e2695420ece06ff17e6a5a8e53a1caa6b0d18be5703e51501194dbf3cba5ee875b0b52d6b3614f938657d4279ba1a8a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac6d3a79894863c2a0614265354e8601ed5ab4f080d79d1fb4010fc83fb5b2d8cef2a22c7e42644e02baa138645d10ffaf24c2e78a732ceb74c2b9a9597dea2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a907036d64da93b2de2ac7272b84f93bba9c3f7f3775bc19e3a397b96d51733ca06b277e76354e035362fcea4063b39d1b4fd2fcd9b811ab7bbf167e7b13bf"} 07:57:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:52 INFO - Contents: 07:57:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9c884ae838e5a66f1af73adb28295e2695420ece06ff17e6a5a8e53a1caa6b0d18be5703e51501194dbf3cba5ee875b0b52d6b3614f938657d4279ba1a8a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac6d3a79894863c2a0614265354e8601ed5ab4f080d79d1fb4010fc83fb5b2d8cef2a22c7e42644e02baa138645d10ffaf24c2e78a732ceb74c2b9a9597dea2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a907036d64da93b2de2ac7272b84f93bba9c3f7f3775bc19e3a397b96d51733ca06b277e76354e035362fcea4063b39d1b4fd2fcd9b811ab7bbf167e7b13bf"} 07:57:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:52 INFO - Copying logs to upload dir... 07:57:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.855987 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-07-15 07:57:52.616503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:52.620398) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 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/sha512/5b9c884ae838e5a66f1af73adb28295e2695420ece06ff17e6a5a8e53a1caa6b0d18be5703e51501194dbf3cba5ee875b0b52d6b3614f938657d4279ba1a8a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac6d3a79894863c2a0614265354e8601ed5ab4f080d79d1fb4010fc83fb5b2d8cef2a22c7e42644e02baa138645d10ffaf24c2e78a732ceb74c2b9a9597dea2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a907036d64da93b2de2ac7272b84f93bba9c3f7f3775bc19e3a397b96d51733ca06b277e76354e035362fcea4063b39d1b4fd2fcd9b811ab7bbf167e7b13bf"} build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/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/sha512/5b9c884ae838e5a66f1af73adb28295e2695420ece06ff17e6a5a8e53a1caa6b0d18be5703e51501194dbf3cba5ee875b0b52d6b3614f938657d4279ba1a8a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac6d3a79894863c2a0614265354e8601ed5ab4f080d79d1fb4010fc83fb5b2d8cef2a22c7e42644e02baa138645d10ffaf24c2e78a732ceb74c2b9a9597dea2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a907036d64da93b2de2ac7272b84f93bba9c3f7f3775bc19e3a397b96d51733ca06b277e76354e035362fcea4063b39d1b4fd2fcd9b811ab7bbf167e7b13bf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:52.645925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:52.646294) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468592610.289915-1141166287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:52.732446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:52.733182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:52.733834) ========= ========= Total master_lag: 0.15 =========