builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1468593370.8 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.801495) ========= 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.801977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.802357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.909644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:10.910026) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-07-15 07:36:10 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.003095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.003416) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015639 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.055589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.055966) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 07:36:11,085 truncating revision to first 12 chars 2016-07-15 07:36:11,085 Setting DEBUG logging. 2016-07-15 07:36:11,085 attempt 1/10 2016-07-15 07:36:11,085 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,390 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.721259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.721579) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.722023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.722328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:11.733482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-15 07:36:11.733805) ========= /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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 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-004', 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": 93, 07:36:12 INFO - "slavename": "talos-linux64-ix-004", 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:19 INFO - Downloaded 1361 bytes. 07:36:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:19 INFO - Using the following test package requirements: 07:36:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'jsshell-linux-x86_64.zip'], 07:36:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:19 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:19 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:19 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:19 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:19 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:19 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:26 INFO - Downloaded 24326108 bytes. 07:36:26 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:26 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:27 INFO - Return code: 0 07:36:27 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:27 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:27 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:27 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:27 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:27 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:27 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:31 INFO - Downloaded 24326108 bytes. 07:36:31 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:31 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:33 INFO - Return code: 0 07:36:33 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:33 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:36:33 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:36:33 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:36:33 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:36:33 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:36:35 INFO - Downloaded 14403317 bytes. 07:36:35 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:36:35 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:36:35 INFO - Return code: 0 07:36: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:36:35 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:36:35 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:36:35 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:36:35 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:36:35 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:36:36 INFO - Downloaded 60811395 bytes. 07:36:36 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:36:36 INFO - mkdir: /builds/slave/test/properties 07:36:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:36 INFO - Contents: 07:36:36 INFO - build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:36:37 INFO - Running post-action listener: _resource_record_post_action 07:36:37 INFO - Running post-action listener: set_extra_try_arguments 07:36:37 INFO - ##### 07:36:37 INFO - ##### Finished download-and-extract step (success) 07:36:37 INFO - ##### 07:36:37 INFO - ##### 07:36:37 INFO - ##### Running populate-webroot step. 07:36:37 INFO - ##### 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: populate_webroot 07:36:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:37 INFO - '--tppagecycles', 07:36:37 INFO - '7'], 07:36:37 INFO - 'tests': ['tsvgm']}}, 07:36:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['damp', 'tps']}, 07:36:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'tests': ['damp', 'tps']}, 07:36:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['dromaeo_dom']}, 07:36:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['basic_compositor_video']}, 07:36:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['a11yr', 07:36:37 INFO - 'ts_paint', 07:36:37 INFO - 'tpaint', 07:36:37 INFO - 'sessionrestore', 07:36:37 INFO - 'sessionrestore_no_auto_restore', 07:36:37 INFO - 'tabpaint']}, 07:36:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['tsvgx', 07:36:37 INFO - 'tsvgr_opacity', 07:36:37 INFO - 'tart', 07:36:37 INFO - 'tscrollx', 07:36:37 INFO - 'cart']}, 07:36:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:37 INFO - 'tsvgr_opacity', 07:36:37 INFO - 'tart', 07:36:37 INFO - 'tscrollx', 07:36:37 INFO - 'cart']}, 07:36:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'talos_options': ['--disable-e10s'], 07:36:37 INFO - 'tests': ['tp5o']}, 07:36:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'tests': ['tp5o']}, 07:36:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'talos_options': ['--disable-e10s', 07:36:37 INFO - '--xperf_path', 07:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:37 INFO - 'tests': ['tp5n']}, 07:36:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:37 INFO - 'talos_options': ['--xperf_path', 07:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:37 INFO - 'tests': ['tp5n']}}, 07:36:37 INFO - 'talos.zip': {'path': '', 07:36:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:37 INFO - Running post-action listener: _resource_record_post_action 07:36:37 INFO - ##### 07:36:37 INFO - ##### Finished populate-webroot step (success) 07:36:37 INFO - ##### 07:36:37 INFO - ##### 07:36:37 INFO - ##### Running create-virtualenv step. 07:36:37 INFO - ##### 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: create_virtualenv 07:36:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:37 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:36:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:37 INFO - Using real prefix '/usr' 07:36:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:40 INFO - Installing pip.................done. 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:36:40 INFO - Using env: {'DISPLAY': ':0', 07:36:40 INFO - 'HOME': '/home/cltbld', 07:36:40 INFO - 'LANG': 'en_US.UTF-8', 07:36:40 INFO - 'LANGUAGE': 'en_US:en', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MAIL': '/var/mail/cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SHLVL': '1', 07:36:40 INFO - 'TERM': 'linux', 07:36:40 INFO - 'TMOUT': '86400', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - '_': '/tools/buildbot/bin/python'} 07:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:40 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:36:40 INFO - Cleaning up... 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:36:40 INFO - Using env: {'DISPLAY': ':0', 07:36:40 INFO - 'HOME': '/home/cltbld', 07:36:40 INFO - 'LANG': 'en_US.UTF-8', 07:36:40 INFO - 'LANGUAGE': 'en_US:en', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MAIL': '/var/mail/cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SHLVL': '1', 07:36:40 INFO - 'TERM': 'linux', 07:36:40 INFO - 'TMOUT': '86400', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - '_': '/tools/buildbot/bin/python'} 07:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:40 INFO - Downloading/unpacking psutil>=3.1.1 07:36:40 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:36:40 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:36:40 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:36:40 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:36:40 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:36:40 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:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:42 INFO - Installing collected packages: psutil 07:36:42 INFO - Running setup.py install for psutil 07:36:42 INFO - building 'psutil._psutil_linux' extension 07:36:42 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:36:42 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:36:42 INFO - building 'psutil._psutil_posix' extension 07:36:42 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:36:43 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:36:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:43 INFO - Successfully installed psutil 07:36:43 INFO - Cleaning up... 07:36:43 INFO - Return code: 0 07:36:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:43 INFO - Using env: {'DISPLAY': ':0', 07:36:43 INFO - 'HOME': '/home/cltbld', 07:36:43 INFO - 'LANG': 'en_US.UTF-8', 07:36:43 INFO - 'LANGUAGE': 'en_US:en', 07:36:43 INFO - 'LOGNAME': 'cltbld', 07:36:43 INFO - 'MAIL': '/var/mail/cltbld', 07:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:43 INFO - 'MOZ_NO_REMOTE': '1', 07:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:43 INFO - 'NO_EM_RESTART': '1', 07:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:43 INFO - 'PWD': '/builds/slave/test', 07:36:43 INFO - 'SHELL': '/bin/bash', 07:36:43 INFO - 'SHLVL': '1', 07:36:43 INFO - 'TERM': 'linux', 07:36:43 INFO - 'TMOUT': '86400', 07:36:43 INFO - 'USER': 'cltbld', 07:36:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:43 INFO - '_': '/tools/buildbot/bin/python'} 07:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36: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:36: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:36: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:36: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:36: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:36: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:36:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:45 INFO - Installing collected packages: mozsystemmonitor 07:36:45 INFO - Running setup.py install for mozsystemmonitor 07:36:45 INFO - Successfully installed mozsystemmonitor 07:36:45 INFO - Cleaning up... 07:36:45 INFO - Return code: 0 07:36:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:45 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:36:45 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:36:45 INFO - Using env: {'DISPLAY': ':0', 07:36:45 INFO - 'HOME': '/home/cltbld', 07:36:45 INFO - 'LANG': 'en_US.UTF-8', 07:36:45 INFO - 'LANGUAGE': 'en_US:en', 07:36:45 INFO - 'LOGNAME': 'cltbld', 07:36:45 INFO - 'MAIL': '/var/mail/cltbld', 07:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:45 INFO - 'MOZ_NO_REMOTE': '1', 07:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:45 INFO - 'NO_EM_RESTART': '1', 07:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:45 INFO - 'PWD': '/builds/slave/test', 07:36:45 INFO - 'SHELL': '/bin/bash', 07:36:45 INFO - 'SHLVL': '1', 07:36:45 INFO - 'TERM': 'linux', 07:36:45 INFO - 'TMOUT': '86400', 07:36:45 INFO - 'USER': 'cltbld', 07:36:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:45 INFO - '_': '/tools/buildbot/bin/python'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:47 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:36:47 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:36:47 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:36:47 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:36:47 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:36:47 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:36:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:47 INFO - warning: no files found matching '*.txt' 07:36:47 INFO - no previously-included directories found matching 'build' 07:36:47 INFO - no previously-included directories found matching 'dist' 07:36:47 INFO - no previously-included directories found matching '.git*' 07:36:47 INFO - Installing collected packages: jsonschema, functools32 07:36:48 INFO - Running setup.py install for functools32 07:36:48 INFO - warning: no files found matching '*.txt' 07:36:48 INFO - no previously-included directories found matching 'build' 07:36:48 INFO - no previously-included directories found matching 'dist' 07:36:48 INFO - no previously-included directories found matching '.git*' 07:36:48 INFO - Successfully installed jsonschema functools32 07:36:48 INFO - Cleaning up... 07:36:48 INFO - Return code: 0 07:36:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:48 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:36:48 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:36:48 INFO - Using env: {'DISPLAY': ':0', 07:36:48 INFO - 'HOME': '/home/cltbld', 07:36:48 INFO - 'LANG': 'en_US.UTF-8', 07:36:48 INFO - 'LANGUAGE': 'en_US:en', 07:36:48 INFO - 'LOGNAME': 'cltbld', 07:36:48 INFO - 'MAIL': '/var/mail/cltbld', 07:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:48 INFO - 'MOZ_NO_REMOTE': '1', 07:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:48 INFO - 'NO_EM_RESTART': '1', 07:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:48 INFO - 'PWD': '/builds/slave/test', 07:36:48 INFO - 'SHELL': '/bin/bash', 07:36:48 INFO - 'SHLVL': '1', 07:36:48 INFO - 'TERM': 'linux', 07:36:48 INFO - 'TMOUT': '86400', 07:36:48 INFO - 'USER': 'cltbld', 07:36:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:48 INFO - '_': '/tools/buildbot/bin/python'} 07:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:48 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:36:48 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:36:48 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:36:48 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:36:48 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:36:48 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:36:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 INFO - Downloading docopt-0.6.1.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:51 INFO - Running setup.py install for blobuploader 07:36:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:51 INFO - Running setup.py install for requests 07:36:51 INFO - Running setup.py install for docopt 07:36:51 INFO - Successfully installed blobuploader requests docopt 07:36:51 INFO - Cleaning up... 07:36:51 INFO - Return code: 0 07:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 07:36:51 INFO - 'HOME': '/home/cltbld', 07:36:51 INFO - 'LANG': 'en_US.UTF-8', 07:36:51 INFO - 'LANGUAGE': 'en_US:en', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MAIL': '/var/mail/cltbld', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SHLVL': '1', 07:36:51 INFO - 'TERM': 'linux', 07:36:51 INFO - 'TMOUT': '86400', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - '_': '/tools/buildbot/bin/python'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Running setup.py (path:/tmp/pip-uqr74q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Running setup.py (path:/tmp/pip-Nu_qd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:51 INFO - Running setup.py (path:/tmp/pip-FvQTDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:52 INFO - Running setup.py (path:/tmp/pip-wvFFnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:52 INFO - Running setup.py (path:/tmp/pip-4tlPYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:52 INFO - Running setup.py (path:/tmp/pip-TmidH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:52 INFO - Running setup.py (path:/tmp/pip-lbztyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:52 INFO - Running setup.py (path:/tmp/pip-454x68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:52 INFO - Running setup.py (path:/tmp/pip-WXaC7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:52 INFO - Running setup.py (path:/tmp/pip-zUVopQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:52 INFO - Running setup.py (path:/tmp/pip-uaF9d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:52 INFO - Running setup.py (path:/tmp/pip-z1_mZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Running setup.py (path:/tmp/pip-lBYRz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Running setup.py (path:/tmp/pip-_bevq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Running setup.py (path:/tmp/pip-91tV67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Running setup.py (path:/tmp/pip-lk2YDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:52 INFO - Running setup.py (path:/tmp/pip-JYZr01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:53 INFO - Running setup.py install for manifestparser 07:36:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozcrash 07:36:53 INFO - Running setup.py install for mozdebug 07:36:53 INFO - Running setup.py install for mozdevice 07:36:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozfile 07:36:53 INFO - Running setup.py install for mozhttpd 07:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozinfo 07:36:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozInstall 07:36:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozleak 07:36:53 INFO - Running setup.py install for mozlog 07:36:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Running setup.py install for moznetwork 07:36:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Running setup.py install for mozprocess 07:36:54 INFO - Running setup.py install for mozprofile 07:36:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Running setup.py install for mozrunner 07:36:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Running setup.py install for mozscreenshot 07:36:54 INFO - Running setup.py install for moztest 07:36:54 INFO - Running setup.py install for mozversion 07:36:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:54 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:54 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:36:54 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:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:55 INFO - Running setup.py (path:/tmp/pip-E5XKfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:55 INFO - Running setup.py (path:/tmp/pip-7l3OWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:55 INFO - Running setup.py (path:/tmp/pip-iCLcjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:55 INFO - Running setup.py (path:/tmp/pip-dm3eAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:55 INFO - Running setup.py (path:/tmp/pip-zmKhnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:55 INFO - Running setup.py (path:/tmp/pip-Y_tDri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:55 INFO - Running setup.py (path:/tmp/pip-sL0iUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:55 INFO - Running setup.py (path:/tmp/pip-VI2l_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:55 INFO - Running setup.py (path:/tmp/pip-yfFcjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:55 INFO - Running setup.py (path:/tmp/pip-YraHt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 INFO - Running setup.py (path:/tmp/pip-EFkIWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 INFO - Running setup.py (path:/tmp/pip-5zkDwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 INFO - Running setup.py (path:/tmp/pip-hts2uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:56 INFO - Running setup.py (path:/tmp/pip-lT_zfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:56 INFO - Running setup.py (path:/tmp/pip-9dYbr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:56 INFO - Running setup.py (path:/tmp/pip-U5lJID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:56 INFO - Running setup.py (path:/tmp/pip-1DiDhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:56 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:36:56 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:36:56 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:36:56 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:36:56 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:36:56 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:36:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:58 INFO - Downloading blessings-1.6.tar.gz 07:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:58 INFO - Installing collected packages: blessings 07:36:58 INFO - Running setup.py install for blessings 07:36:58 INFO - Successfully installed blessings 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Current package versions: 07:36:58 INFO - argparse == 1.2.1 07:36:58 INFO - blessings == 1.6 07:36:58 INFO - blobuploader == 1.2.4 07:36:58 INFO - docopt == 0.6.1 07:36:58 INFO - functools32 == 3.2.3-2 07:36:58 INFO - jsonschema == 2.5.1 07:36:58 INFO - manifestparser == 1.1 07:36:58 INFO - mozInstall == 1.12 07:36:58 INFO - mozcrash == 0.17 07:36:58 INFO - mozdebug == 0.1 07:36:58 INFO - mozdevice == 0.48 07:36:58 INFO - mozfile == 1.2 07:36:58 INFO - mozhttpd == 0.7 07:36:58 INFO - mozinfo == 0.9 07:36:58 INFO - mozleak == 0.1 07:36:58 INFO - mozlog == 3.2 07:36:58 INFO - moznetwork == 0.27 07:36:58 INFO - mozprocess == 0.23 07:36:58 INFO - mozprofile == 0.28 07:36:58 INFO - mozrunner == 6.12 07:36:58 INFO - mozscreenshot == 0.1 07:36:58 INFO - mozsystemmonitor == 0.3 07:36:58 INFO - moztest == 0.7 07:36:58 INFO - mozversion == 1.4 07:36:58 INFO - psutil == 3.1.1 07:36:58 INFO - requests == 1.2.3 07:36:58 INFO - wsgiref == 0.1.2 07:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x1bbf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:59 INFO - Cleaning up... 07:36:59 INFO - Return code: 0 07:36:59 INFO - Running post-action listener: _resource_record_post_action 07:36:59 INFO - Running post-action listener: _start_resource_monitoring 07:36:59 INFO - Starting resource monitoring. 07:36:59 INFO - ##### 07:36:59 INFO - ##### Finished create-virtualenv step (success) 07:36:59 INFO - ##### 07:36:59 INFO - ##### 07:36:59 INFO - ##### Running install step. 07:36:59 INFO - ##### 07:36:59 INFO - Running pre-action listener: _resource_record_pre_action 07:36:59 INFO - Running main action method: install 07:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:59 INFO - Reading from file tmpfile_stdout 07:36:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:59 INFO - Reading from file tmpfile_stdout 07:36:59 INFO - Output received: 07:36:59 INFO - Usage: mozinstall [options] installer 07:36:59 INFO - Options: 07:36:59 INFO - -h, --help show this help message and exit 07:36:59 INFO - -d DEST, --destination=DEST 07:36:59 INFO - Directory to install application into. [default: 07:36:59 INFO - "/builds/slave/test"] 07:36:59 INFO - --app=APP Application being installed. [default: firefox] 07:36:59 INFO - mkdir: /builds/slave/test/build/application 07:36:59 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:36:59 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:37:16 INFO - Reading from file tmpfile_stdout 07:37:16 INFO - Output received: 07:37:16 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:16 INFO - Running post-action listener: _resource_record_post_action 07:37:16 INFO - ##### 07:37:16 INFO - ##### Finished install step (success) 07:37:16 INFO - ##### 07:37:16 INFO - ##### 07:37:16 INFO - ##### Running run-tests step. 07:37:16 INFO - ##### 07:37:16 INFO - Running pre-action listener: _resource_record_pre_action 07:37:16 INFO - Running main action method: run_tests 07:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:16 INFO - Python 2.7.3 07:37:16 INFO - Return code: 0 07:37:16 INFO - grabbing minidump binary from tooltool 07:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:16 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 0x1e7e3b0>, '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 0x1e7f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:16 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:37:16 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:37:16 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:37:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:16 INFO - Return code: 0 07:37:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:16 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-004', '--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:37:16 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-004 --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:37:16 INFO - Using env: {'DISPLAY': ':0', 07:37:16 INFO - 'HOME': '/home/cltbld', 07:37:16 INFO - 'LANG': 'en_US.UTF-8', 07:37:16 INFO - 'LANGUAGE': 'en_US:en', 07:37:16 INFO - 'LOGNAME': 'cltbld', 07:37:16 INFO - 'MAIL': '/var/mail/cltbld', 07:37:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:16 INFO - 'MOZ_NO_REMOTE': '1', 07:37:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:16 INFO - 'NO_EM_RESTART': '1', 07:37:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:16 INFO - 'PWD': '/builds/slave/test', 07:37:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:16 INFO - 'SHELL': '/bin/bash', 07:37:16 INFO - 'SHLVL': '1', 07:37:16 INFO - 'TERM': 'linux', 07:37:16 INFO - 'TMOUT': '86400', 07:37:16 INFO - 'USER': 'cltbld', 07:37:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124', 07:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:16 INFO - '_': '/tools/buildbot/bin/python'} 07:37:16 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-004', '--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:37:17 INFO - mozversion application_buildid: 20160713163005 07:37:17 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:37:17 INFO - mozversion application_display_name: Nightly 07:37:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:17 INFO - mozversion application_name: Firefox 07:37:17 INFO - mozversion application_remotingname: firefox 07:37:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:17 INFO - mozversion application_vendor: Mozilla 07:37:17 INFO - mozversion application_version: 50.0a1 07:37:17 INFO - mozversion platform_buildid: 20160713163005 07:37:17 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:37:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:17 INFO - mozversion platform_version: 50.0a1 07:37:17 INFO - using testdate: 1468593437 07:37:17 INFO - actual date: 1468593437 07:37:17 INFO - starting webserver on 'localhost:51388' 07:37:17 INFO - SUITE-START | Running 2 tests 07:37:17 INFO - TEST-START | dromaeo_css 07:37:17 INFO - operating with platform_type : linux_ 07:37:17 INFO - Initialising browser for dromaeo_css test... 07:37:17 INFO - TEST-INFO | started process 4944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHideD/profile http://localhost:51388/getInfo.html) 07:37:21 INFO - PROCESS | 4944 | __metrics Screen width/height:1600/1200 07:37:21 INFO - PROCESS | 4944 | colorDepth:24 07:37:21 INFO - PROCESS | 4944 | Browser inner width/height: 1024/697 07:37:21 INFO - PROCESS | 4944 | __metrics 07:37:22 ERROR - PROCESS | 4944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:37:22 INFO - TEST-INFO | 4944: exit 0 07:37:22 INFO - Browser initialized. 07:37:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:22 INFO - TEST-INFO | started process 5066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHideD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:34 INFO - PROCESS | 5066 | RSS: Main: 167247872 07:37:34 INFO - PROCESS | 5066 | 07:38:24 INFO - PROCESS | 5066 | 1468593504442 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:40:31 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51388/tests/dromaeo/cssquery-ext.html) 07:40:33 INFO - PROCESS | 5066 | RSS: Main: 170524672 07:40:33 INFO - PROCESS | 5066 | 07:43:35 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-ext.html (next: http://localhost:51388/tests/dromaeo/cssquery-jquery.html) 07:43:35 INFO - PROCESS | 5066 | RSS: Main: 168042496 07:43:35 INFO - PROCESS | 5066 | 07:46:37 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51388/tests/dromaeo/cssquery-mootools.html) 07:46:38 INFO - PROCESS | 5066 | RSS: Main: 171061248 07:46:38 INFO - PROCESS | 5066 | 07:49:39 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51388/tests/dromaeo/cssquery-prototype.html) 07:49:40 INFO - PROCESS | 5066 | RSS: Main: 166699008 07:49:40 INFO - PROCESS | 5066 | 07:52:43 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51388/tests/dromaeo/cssquery-yui.html) 07:52:43 INFO - PROCESS | 5066 | RSS: Main: 168153088 07:52:43 INFO - PROCESS | 5066 | 07:55:45 INFO - PROCESS | 5066 | Cycle 1(1): loaded http://localhost:51388/tests/dromaeo/cssquery-yui.html (next: http://localhost:51388/tests/dromaeo/cssquery-dojo.html) 07:55:46 INFO - PROCESS | 5066 | RSS: Main: 169930752 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | __start_tp_report 07:55:46 INFO - PROCESS | 5066 | _x_x_mozilla_page_load 07:55:46 INFO - PROCESS | 5066 | _x_x_mozilla_page_load_details 07:55:46 INFO - PROCESS | 5066 | |i|pagename|runs| 07:55:46 INFO - PROCESS | 5066 | |0;dojo.html;3074.2160749009004;3119.797213181143;3126.1403114143595;3126.1559378967663;3127.6403213630424;5484.204790305404;5554.888902221958;5587.580931430139;5593.356763972144;5601.719914004294;5497.202905578689;5502.477264659851;5536.446355364462;5609.691466969315;5617.662940223589;4971.925421118686;5030.471800460936;5134.358205224347;5183.041137389595;5215.191645294985;493.3196300102774;4939.036887806879;4995.725235112068;5035.118854200518;5088.898222035557;5007.874803129915;5033.748312584375;5049.368828896388;5052.191649336107;5055.11535481293;5060.974695126501;5065.037642847848;5081.669691470042;5082.695038297677;5102.209157580581;4891.5353041461;4897.363342765453;4903.681260718042;4928.162212423897;4928.26076088586;5388.164834450667;5404.7838086476495;5460.34475862899;5461.69960652164;5475.0418676731415;5728.112142617901;5818.883622327529;5822.7088645567555;5825.38833422493;5855;5934.080217566241;5936.990711579042;5954.642721436684;5987;6035.909461358083;5512.39363669996;5514.255575497296;5528.75120619573;5543.805966791143;5573.024720673907;5849.649021058665;5905.261842269716;6095.512359011268;6097.512199024068;6098.634081955097;5695.857603559944;5705;5731.484166425042;5738.196652468658;5744.798932037442;5795.913061304083;5798.449147330997;5802.82591522255;5814.709264536757;5823.4467725566;5717.599768016199;5784.363719990798;5799.623024503394;5846.064629659234;5863.120531920246;5897.557683173779;5906.8818623627285;5918.437748413894;5955.493783028491;5961.344252132262;4516.277395616686;4527.886802829956;4529.592336689648;4534.047849951481;4535.548152965537;3898.688104951597;3983.50206224222;4009.8797036088963;4030.6573941214738;4035.7780322082567;5568.443155684399;5572.665640061609;5583.776648933997;5611.158326251013;5686.289213848269;5938.465538101592;5996.760129594767;5997.040473524303;6000.429959153874;6008.519318454513;5517.806876759294;5523.834284971457;5550.306211723535;5554.222408862763;5567.192757050286;5019.121653710586;5038;5059.443461219263;5067.366579177603;5102.36220472441;5972.492338151305;6046.637201767908;6056.424639659225;6060.939390606126;6068;5898.8230353089475;5951.7024148791525;5959.344472107978;5997.790077347447;6001.039833626599;6097.542684298606;6117.296510901126;6117.327094019565;6146.692665366624;6177.289611694533;5675.460831221028;5839;5847.502962248256;5873.471387575139;5894.440028197314;5820.330661973927;5841.32824725162;5856.443637854397;5877.324107727666;5879.029960056543;5667.518260947701;5692.857678558069;5706.001449746194;5746.770129194785;5754.280714910637;5648.350439699487;5679.574031947538;5695.373508914099;5724.3703192647945;5753.712314384347;5723.771049158154;5739.799107031234;5760.423957604206;5803.390643982321;5826.796062137805;5749.540036796962;5776.884462310646;5806.158107074366;5818.0981947798155;5823.213866128188;5487.725613719218;5648.830535083954;5684.232628595252;5737.540996720169;5751.1085781703905 07:55:46 INFO - PROCESS | 5066 | |1;ext.html;552.6254556736213;584.339696143358;590.0382376725936;614.2598169206107;622.8536293970919;41458;46138;46146.53853461464;46221;46225;45370.77314613431;46021.76989115058;46096.5427592931;46172.307415388714;46211.76894115525;8912.376133670645;9041.638334466614;9069.727908162766;9072.228860546862;9084;8977.640894364251;9027.909720902773;9075.047120052399;9076.727698169065;9078.137576930214;9084.77288067797;9140.725778226664;9140.908590914072;9143.817123657524;9166.587503562323;9097.363184577081;9132.452052876848;9139.862902056475;9151.359404841663;9158.67944621935;9054.864177037283;9079.954600226956;9122.22461090808;9128.406653567497;9129.132732390412;33704.15739606505;43670.56329436697;43819.78090109561;43997.34003989943;44096.55903440957;3516.7186625069935;3534.32847758925;3582.4805403216387;3670.302642497917;3983.8406463741417;32590.674093259;32928.506072408934;33044.83477582597;33105;33183.336333273444;4304.9139017219795;4359.38968544404;4370.475542934836;4398.73607583546;4417.072414792898;336810;337814;338648.99999999756;339107;340759;36343;36718.632813672055;36720;36725;36776.632233677854;36891.81554092266;37689.81155094207;37744.24511509809;37887.81056094702;39675.603243967766;17461.126943652765;17500.21249043796;17519.38682146144;17524.47426577205;17614.823851761575;13313.800292995613;13385.464581416634;13457.327133643279;13480.730385392237;13483.460661573623;20472.385828425173;20555.486112847;20631;20654.277100301417;20697.68953465699;7234.312740289664;7351.191368949411;7628.694852205849;7672;7803.141654418009;945.4825005865487;1079.0773888325525;1108.3460758152728;1143.108375467137;1209.9274043557239;34271.65728342735;34345.65654343425;34415.13962150916;34700.47949280763;34925.30149396998;1142.7485953090472;1155.4684844971407;1170.5083864776814;1187.6140254417348;1190.7380376317196;17184.82815171857;18199.818001820076;18205.27178912829;18309.908450457664;18329;618844;625925;627511;632780;634220;62977.68511157415;63125;63416.36583634104;63596.68201658962;63777.68111159507;1321.722438287951;1373.7252549490142;1390.2701081931864;1399.762040453105;1405.100735529262;32888.835555822065;33664.49503257502;33742;33825.323493530486;34390.656093438745;53844;54909.450905490434;55020.44979550153;55235.44764552303;55251.17123243235;507842;511189;513035;515253;515345;29233;29591.556126657688;29746.702532975258;29788;29845.10464686063;51355.48644513507;51532.74233628808;52885;53083.20375194298;54023.729881350344;43409.488576713746;44070.559294406645;44195.337069943336;44740.77629611831;44869.775651121534;43986.56013439825;44067.33898991582;44166.55833441753;45094.77452612716;45744;43922.34116488319;44070.77964610157;44731.552684472736;44866.77566612146;45968.31047534357;37954.2409151821;38949.6105038946;39547.40678889876;40583.7970810144;40720.3891941627;29416.852915735286;29528.11415657534;30952.380952381278;31418.371632566763;31828.681713183498 07:55:46 INFO - PROCESS | 5066 | |2;jquery.html;384.3792275475109;385.0470086535824;393.76374175494726;400.9498812648419;417.53444908926537;19068.809311906876;19646.607067858633;20311;20704.99999999998;20707.275245366414;19746.407607771755;19855.801441985575;19936.302229421974;20404.591908161827;20482.590348193025;5684.317881854184;5689.345725241609;5940.821775346746;5990.970045149768;6087.847803804896;5963.970180149115;5970.044792833148;6004.5796794224425;6017.729202185912;6022.337542870303;6100.877982440348;6189;6195.349488303731;6205.069239614071;6209.068639704058;6505.674716264168;6715.093462382565;6804.319568043181;6815.965920170417;6896.896546551806;5858.970705146489;6074.453299203093;6075.422834830684;6082.665453400061;6093.086037094471;13911.165330080228;14419.495317663936;14422.855771442257;14660.120392776467;14908.552743417606;2326.4998025424616;2378.5361854438393;2414.155045733979;2940.8088474249107;3030.8939187128344;10585.15318774504;10624.256302058859;10786.08318292946;10819.242653014293;10863.18526110545;1963.882167069966;2013.3054096336887;2023.6458619741634;2036.4908772806798;2064.95870082599;74766.62616686936;82403.17596824015;83777;90820.09179908248;91059.08940910573;11185.496652650487;11348.865113488586;11510.7410258205;11601.12991525639;11896.22674526153;16119.597010074607;16125.193740312938;16204.75692864608;16212;16248.75626865598;8494.320454363637;8643.56782160902;8685.218330350172;8708.303335733126;8741;8227.259546640711;8297.211764882326;8299.8340033199;8327.916720832834;8447.029895948894;4853.199222128309;4934.777934992934;4956.628252880976;5000.849974500771;5001.57486613642;2025.868318559289;2052.415061707436;2092.853500254998;2130.2863540713724;2132.093860109447;982.1210017034714;995.8257304971601;998.8801343838786;1088.080571916729;1142.2689478733616;20069;20637.484062898246;20716.792832071485;20768.273110441365;20915.581688366452;974.288769198489;1042.4579218806177;1054.5887104029434;1068.8183008888507;1086.9619513364876;10951.853735898663;11423.600173993871;11488.080953523699;11511.539538418538;11554.480048397842;525158;525493;529394;531696;532032;98399.50800245952;99538.502307488;101476;103458.48270758598;107663.46168269265;1023.9539220735085;1036.5957276662107;1073.5383784972537;1074.790415868898;1078.8746170045;14418.495352662607;15514.146721930401;17773.911130444267;17976.460706178834;18237.54406139857;43246;44926.32610510779;45536.54463455456;45578.316325254484;46603.53396465992;67510;67697;68129.65935170293;68170;68796.31203688099;7774.416918731004;8078.030636323679;8082.515049097073;8257.05043919957;8885.200331970154;12825.615231543068;14068.718625627635;14278.143311401349;14583.562493125222;14898.702025959637;12254.693632659255;12450.25298482094;12499.312537810507;12514.31171285588;12818.55135070268;12156.574519891761;12228.938855305667;12293.44679489443;12414.62756117318;12967.481300747864;12439.689007774878;12441.626751197478;12841.101122921305;12871.22772633645;13013.739725205254;9135.31485138604;9184.678536251198;9241.260699143917;9390.76523086901;9487.098725621056;11903;12170.208936419105;12244.816327755269;12324.383780811102;12602.117851750656 07:55:46 INFO - PROCESS | 5066 | |3;mootools.html;1307.9999999999998;1412.675084730512;1434.6700258940443;1767.5404394857333;1790.4002159276633;7572.394208463324;8248.17518248175;8258.83482330353;8806.559672016405;8810.823783524325;8331.250187483125;8559.27246184075;8598.785030374229;8653.30773538117;8693.73918782436;2309.711286089235;2346.8591884486987;2353.9176128835493;2354.2466410748566;2363.89362478688;2320.8143348532076;2333.3583264602285;2352.623580227164;2364.207990323244;2370.442945907719;2313.9884300578556;2335.2293743064747;2340.8127349811975;2352.2707960532202;2362.574736547421;2321.1875843454823;2326.720793504773;2333.2416964486524;2334.568104900599;2336.754640762721;2290.061074959259;2295.2081531871477;2296.3799774061076;2306.1467257114973;2306.8269879759087;8651.264642505395;8690.782730431727;8715.69495067676;8764.956175219084;8766.035736069027;5029.622778291643;5128.487151284879;5136.871578210575;5171.3277273954145;5180.067587834188;3323.4350160472777;3424.366492198951;3452.879149229765;3462.0745470077745;3537.620328072054;1218.6405010521828;1276.2151276964694;1307.627326212025;1312.1536608887309;1334.0194956706812;11924.582639607659;11980.221285616493;12034.458449369711;12053.276803391824;12053.758924821455;4435.1351486459835;4542.409486766699;4656.697314674535;4686.625069994392;4694;10148.137408320375;10154.593816247416;10161.288709790391;10174.643887464052;10225.744356391;5257.579393648499;5270.604704647167;5272;5293.417724050351;5302.549283310962;4151.7924103794685;4573.428321459817;4630.884227894329;4654.511276315938;4840.685355451885;3910.3156947534635;3942.211557688474;4017.0760725032824;4055.1281474483126;4066.4103704962613;1208.601161616682;1209.9455524501418;1210.3222195570509;1221.3893053473264;1242.521629172757;947.6541062512272;964.6430820596424;971.718201721507;978.6966040527459;982.3565564555084;5592.664440133605;5694.829155125353;5707.771689132472;5738.626989245686;5797.01450753373;1042.8696412948382;1086.1528008153653;1086.179934149712;1090.4983707494482;1104.5526561742347;3916.8824935251987;4076.510818701775;4091.7026875114957;4150.750954942713;4151.6886233532605;10538;10872.836907446395;10897.782044359226;10925.235233533735;10955.945220273848;10815.78368432627;10865.293755905841;10871.29336593119;10873.075788557902;10892.564297428014;7655.425843061793;7870.331021863091;7956;7963.442559020813;8073.19268073188;6069.878602427839;6185.2886918003205;6225.688715564113;6259.874802503833;6346.079818426395;9961.252906032221;9985.101340879355;9988.500574971367;10146.036126567964;10167.898321016992;10086.747831304276;10235.437050962268;10258;10279.383237005804;10335.483225838527;6717.697703603448;7269.091363579552;7388.556686598821;7621.69513219465;7813.687452501837;8130;8148.592570371339;8164.306033987177;8189.140140285184;8201.343892488705;7195.8560828784175;7362.595057271901;7423.517471364344;7460.888086678596;7480.3641690456925;7048.859022819617;7236.167840698387;7395.667194976347;7581.431392645684;7638.312551870358;7051.858962820817;7073.964630176816;7095.254998225112;7120.359167674934;7128.643567821692;5026.246063090565;5093.974530127474;5136.563392111712;5163.173892177234;5196;5253.684778913277;5254.369475662945;5302.212158160661;5336.973315133399;5416.620836541404 07:55:46 INFO - PROCESS | 5066 | |4;prototype.html;329.581431581891;334.07461332110057;334.3179912977526;338.7747148146483;340.4688685650386;5603.327600687918;5625.578081643877;5642.7742890284335;5650.208970744094;5681.3466451358;5590.413006634306;5628.0713682242385;5630;5651.180578816069;5664.943350566493;4185.6651467882575;4284.378765079062;4377.321515165155;4404;4413.867583972486;4351.6953813233085;4390.792532053679;4392.472903251598;4393.428854248943;4425.645948324126;4367.825286988516;4386.802593883267;4391.736495810245;4396.955415731684;4412.1175764847;4313.849015284466;4375.621679171083;4389.561043895616;4394.318880573516;4399.142167277382;3854.1520865409566;3876;3881.5536213335545;3888.6111388860886;3900.4734360861203;5544.362398324204;5545.085060964936;5545.77816887324;5557.527610153142;5558.527525160366;4702.5297470253045;4969.763606377109;4980.153373926441;4981.9750901245625;4992.500749924979;5858.744383412374;5882.970585147047;5900.409959004065;5930.911036334458;5947.881042379128;4133.875983720493;4174.853880114212;4175.123224122938;4183.581641835823;4185.895352616179;5910.822675319747;6017.187679663233;6035.849103772397;6081.385004448086;6111.908321375183;4276.743395396286;4279.957200428018;4280.978595107067;4287.506936702319;4293.248681480728;4356.451475886642;4364.1708075466195;4368.890777730582;4371.409859668967;4376.890577735582;4865.783554111472;4891.9755401222765;4930.778114984834;4931.446594322777;4953.455119936804;5926.970365148233;5937.456261371988;5971.940280597225;5975.940240597625;6004.789832355847;1480.9629759256104;1492.6268432891777;1493.6191271225769;1493.8431464696268;1496.8503149684943;981.2003217377815;1005.894381089975;1014.6905193915926;1029.7322696099068;1031.3657100882904;5437.858049809505;5641.605087643908;5652.6325788824415;5665.49010589049;5669.348024977098;6012.338642749294;6028.156058151862;6079.270487541523;6089.756409743649;6093.512518998469;5474.288342515448;5695.202671625976;5745.741441635137;5784.1034639630925;5784.2769653793275;3222.050659351059;3264.249222678797;3269.5095735639843;3274.9192766387036;3280.8851690190727;6245.125682404467;6306.621602703853;6358.554901156875;6359.904601430982;6369.9681501592195;6203.7828675996125;6241.157443745127;6276.897239424752;6288.213973253343;6289.465395441439;6072.696365181635;6290.968545157337;6318.273398559132;6346.777862774781;6369.649669268142;6086.817395478142;6102.359252278625;6109.816705498843;6160.229971253593;6169.691515424301;5998.910016349845;6003.519718422428;6026.8794624106395;6034.2155519782145;6077.149199112217;5916.467517923407;6244.875102497834;6264.9976003839165;6265.464961084564;6324.367563243823;4312.900210446316;4317.956820431756;4347.434833471629;4355.5426680198125;4369.3664418659755;5877.647341159544;6172.969135154295;6201.627902325875;6207.81376558704;6212.161358216583;5940.257467816523;5990.64056156632;6016.398360163948;6025.216721826135;6027.819165425044;5972.70136493165;5979.521638269015;5983;5986.880262394815;6011.6693581853415;5592.636478628876;5828.59199856006;5856.267966504187;5866.325372582208;5902.1146827976145;5929.1995580597795;5981.312149102909;5986.844735895162;6024.969875150597;6035.021107586346;5633.8591535211945;5799.420057994335;5874.647521148745;5911.408859114054;5912.674802885883 07:55:46 INFO - PROCESS | 5066 | |5;yui.html;752.3830459023603;767.5471471831622;780.2587541835258;792.0930534537954;887.7159309021114;14692.338844751985;15755.921220393911;15808.604784880385;15813.288402021908;15862.444814431497;15094.54716358511;15250;15256;15334.539963801077;15512.612184695388;820.2044017303207;838.1074156023845;838.6687258532907;840.5503055865113;841.8653015517518;796.41861441148;829.2495291760966;829.4691397505601;831.8710599857031;832.5296207642692;870.5951732444412;872.1322284327103;872.3457406944791;872.9694460693877;874.0647507167333;855.3328403845011;856.1823458597025;856.2678909532353;856.9657213711444;859.1537335724306;630.9432151106422;631.7125707802938;633.9887878833254;635.8378613453586;638.1990601794764;14467.710645787025;14485.927570362186;14539.200343981076;14570.92714536431;14574.417023319054;15063.54809355721;15450.1502417367;15461.149636769973;15495.612609684735;15543.689126217525;12200.572979945659;12442.315672638002;12512.186707863959;12542.435590398363;12686.555970540987;3900.843966241347;3926.3128952433494;3938.5667576566557;3996.200759848042;4083.448734420845;77095;79475.20524794793;79886;81206;82083.5895820523;11835.763284734257;11984.400779960966;12034.939825300993;12124;12237.265764054007;22314.10743570239;22334.888325558593;22420.215292464687;22435.55128897413;22697.319080427613;9050.909490905007;9063.365564410427;9120.543972801333;9134.177923986874;9181.357304988587;5055.3428054353435;5067.6452648315;5088.6946783193125;5148.33071700684;5316;3647.3617117004947;3742.9438558421643;3757.0231739747865;3771.905702357463;3779;630.9400606942334;639.1754636518931;647.2233320015999;652.6704014472756;655.3937607712846;637.6142433827561;727.6070921702221;763.8319569694659;779.033997842671;811.1158836867843;9800.529920511837;9908.801823963624;9937.354071985297;10230.795384092276;10242.692719218436;599.5353600959291;715.8675645005691;733.3839574757122;765.3456294867808;772.4554189296532;5011;5094.439611642716;5129.230615407719;5133.409657889316;5162.1224391853475;100219;121074.39462802629;121777;122424;123579;79582.6020869892;107850;108308;108454.45772771243;108753;92695.53652231695;93192.53403733074;93906;95676.52161739147;96566.51716741371;9402.43585384879;9534.995514984117;9631.614735410505;9710.805783884141;9792.412455252708;54351.72824135854;54781.72609136929;55010;55260;56601;67744;74490;83766;84211;85777;13455.394507247001;13523.932380338036;14312.355943982337;14339.283035848375;14626;15185.544433667008;15211.467598633995;15277.77083343773;15446.150461724263;15791;14941.77587336169;15037.323320450387;15047.623809404853;15099.54701358961;15128.470503532764;13822.585322440344;14209.928950355183;14398.136111833324;14688.853111468748;14913.403463861325;14495;14870.925645372137;14949.626259343604;15103.244837757848;15532.767008495108;12228.327441990776;12244.326562038817;12267;12323.137380383287;12443.377831108228;11248.217398193527;11616.477258523555;11754.412279386168;12103;12610.810837837624 07:55:46 INFO - PROCESS | 5066 | __end_tp_report 07:55:46 INFO - PROCESS | 5066 | __start_cc_report 07:55:46 INFO - PROCESS | 5066 | _x_x_mozilla_cycle_collect,381 07:55:46 INFO - PROCESS | 5066 | __end_cc_report 07:55:46 INFO - PROCESS | 5066 | __startTimestamp1468594546124__endTimestamp 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | ------- Summary: start ------- 07:55:46 INFO - PROCESS | 5066 | Number of tests: 6 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#0] dojo.html Cycles:165 Average:5444.48 Median:5692.86 stddev:737.28 (13.0%) stddev-sans-first:715.71 07:55:46 INFO - PROCESS | 5066 | Values: 3074.2 3119.8 3126.1 3126.2 3127.6 5484.2 5554.9 5587.6 5593.4 5601.7 5497.2 5502.5 5536.4 5609.7 5617.7 4971.9 5030.5 5134.4 5183.0 5215.2 493.3 4939.0 4995.7 5035.1 5088.9 5007.9 5033.7 5049.4 5052.2 5055.1 5061.0 5065.0 5081.7 5082.7 5102.2 4891.5 4897.4 4903.7 4928.2 4928.3 5388.2 5404.8 5460.3 5461.7 5475.0 5728.1 5818.9 5822.7 5825.4 5855.0 5934.1 5937.0 5954.6 5987.0 6035.9 5512.4 5514.3 5528.8 5543.8 5573.0 5849.6 5905.3 6095.5 6097.5 6098.6 5695.9 5705.0 5731.5 5738.2 5744.8 5795.9 5798.4 5802.8 5814.7 5823.4 5717.6 5784.4 5799.6 5846.1 5863.1 5897.6 5906.9 5918.4 5955.5 5961.3 4516.3 4527.9 4529.6 4534.0 4535.5 3898.7 3983.5 4009.9 4030.7 4035.8 5568.4 5572.7 5583.8 5611.2 5686.3 5938.5 5996.8 5997.0 6000.4 6008.5 5517.8 5523.8 5550.3 5554.2 5567.2 5019.1 5038.0 5059.4 5067.4 5102.4 5972.5 6046.6 6056.4 6060.9 6068.0 5898.8 5951.7 5959.3 5997.8 6001.0 6097.5 6117.3 6117.3 6146.7 6177.3 5675.5 5839.0 5847.5 5873.5 5894.4 5820.3 5841.3 5856.4 5877.3 5879.0 5667.5 5692.9 5706.0 5746.8 5754.3 5648.4 5679.6 5695.4 5724.4 5753.7 5723.8 5739.8 5760.4 5803.4 5826.8 5749.5 5776.9 5806.2 5818.1 5823.2 5487.7 5648.8 5684.2 5737.5 5751.1 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#1] ext.html Cycles:180 Average:64638.63 Median:24095.13 stddev:135179.55 (561.0%) stddev-sans-first:135473.13 07:55:46 INFO - PROCESS | 5066 | Values: 552.6 584.3 590.0 614.3 622.9 41458.0 46138.0 46146.5 46221.0 46225.0 45370.8 46021.8 46096.5 46172.3 46211.8 8912.4 9041.6 9069.7 9072.2 9084.0 8977.6 9027.9 9075.0 9076.7 9078.1 9084.8 9140.7 9140.9 9143.8 9166.6 9097.4 9132.5 9139.9 9151.4 9158.7 9054.9 9080.0 9122.2 9128.4 9129.1 33704.2 43670.6 43819.8 43997.3 44096.6 3516.7 3534.3 3582.5 3670.3 3983.8 32590.7 32928.5 33044.8 33105.0 33183.3 4304.9 4359.4 4370.5 4398.7 4417.1 336810.0 337814.0 338649.0 339107.0 340759.0 36343.0 36718.6 36720.0 36725.0 36776.6 36891.8 37689.8 37744.2 37887.8 39675.6 17461.1 17500.2 17519.4 17524.5 17614.8 13313.8 13385.5 13457.3 13480.7 13483.5 20472.4 20555.5 20631.0 20654.3 20697.7 7234.3 7351.2 7628.7 7672.0 7803.1 945.5 1079.1 1108.3 1143.1 1209.9 34271.7 34345.7 34415.1 34700.5 34925.3 1142.7 1155.5 1170.5 1187.6 1190.7 17184.8 18199.8 18205.3 18309.9 18329.0 618844.0 625925.0 627511.0 632780.0 634220.0 62977.7 63125.0 63416.4 63596.7 63777.7 1321.7 1373.7 1390.3 1399.8 1405.1 32888.8 33664.5 33742.0 33825.3 34390.7 53844.0 54909.5 55020.4 55235.4 55251.2 507842.0 511189.0 513035.0 515253.0 515345.0 29233.0 29591.6 29746.7 29788.0 29845.1 51355.5 51532.7 52885.0 53083.2 54023.7 43409.5 44070.6 44195.3 44740.8 44869.8 43986.6 44067.3 44166.6 45094.8 45744.0 43922.3 44070.8 44731.6 44866.8 45968.3 37954.2 38949.6 39547.4 40583.8 40720.4 29416.9 29528.1 30952.4 31418.4 31828.7 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#2] jquery.html Cycles:180 Average:30974.26 Median:11504.22 stddev:87336.59 (759.2%) stddev-sans-first:87551.39 07:55:46 INFO - PROCESS | 5066 | Values: 384.4 385.0 393.8 400.9 417.5 19068.8 19646.6 20311.0 20705.0 20707.3 19746.4 19855.8 19936.3 20404.6 20482.6 5684.3 5689.3 5940.8 5991.0 6087.8 5964.0 5970.0 6004.6 6017.7 6022.3 6100.9 6189.0 6195.3 6205.1 6209.1 6505.7 6715.1 6804.3 6816.0 6896.9 5859.0 6074.5 6075.4 6082.7 6093.1 13911.2 14419.5 14422.9 14660.1 14908.6 2326.5 2378.5 2414.2 2940.8 3030.9 10585.2 10624.3 10786.1 10819.2 10863.2 1963.9 2013.3 2023.6 2036.5 2065.0 74766.6 82403.2 83777.0 90820.1 91059.1 11185.5 11348.9 11510.7 11601.1 11896.2 16119.6 16125.2 16204.8 16212.0 16248.8 8494.3 8643.6 8685.2 8708.3 8741.0 8227.3 8297.2 8299.8 8327.9 8447.0 4853.2 4934.8 4956.6 5000.8 5001.6 2025.9 2052.4 2092.9 2130.3 2132.1 982.1 995.8 998.9 1088.1 1142.3 20069.0 20637.5 20716.8 20768.3 20915.6 974.3 1042.5 1054.6 1068.8 1087.0 10951.9 11423.6 11488.1 11511.5 11554.5 525158.0 525493.0 529394.0 531696.0 532032.0 98399.5 99538.5 101476.0 103458.5 107663.5 1024.0 1036.6 1073.5 1074.8 1078.9 14418.5 15514.1 17773.9 17976.5 18237.5 43246.0 44926.3 45536.5 45578.3 46603.5 67510.0 67697.0 68129.7 68170.0 68796.3 7774.4 8078.0 8082.5 8257.1 8885.2 12825.6 14068.7 14278.1 14583.6 14898.7 12254.7 12450.3 12499.3 12514.3 12818.6 12156.6 12228.9 12293.4 12414.6 12967.5 12439.7 12441.6 12841.1 12871.2 13013.7 9135.3 9184.7 9241.3 9390.8 9487.1 11903.0 12170.2 12244.8 12324.4 12602.1 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#3] mootools.html Cycles:180 Average:5730.88 Median:4602.16 stddev:3215.61 (69.9%) stddev-sans-first:3207.45 07:55:46 INFO - PROCESS | 5066 | Values: 1308.0 1412.7 1434.7 1767.5 1790.4 7572.4 8248.2 8258.8 8806.6 8810.8 8331.3 8559.3 8598.8 8653.3 8693.7 2309.7 2346.9 2353.9 2354.2 2363.9 2320.8 2333.4 2352.6 2364.2 2370.4 2314.0 2335.2 2340.8 2352.3 2362.6 2321.2 2326.7 2333.2 2334.6 2336.8 2290.1 2295.2 2296.4 2306.1 2306.8 8651.3 8690.8 8715.7 8765.0 8766.0 5029.6 5128.5 5136.9 5171.3 5180.1 3323.4 3424.4 3452.9 3462.1 3537.6 1218.6 1276.2 1307.6 1312.2 1334.0 11924.6 11980.2 12034.5 12053.3 12053.8 4435.1 4542.4 4656.7 4686.6 4694.0 10148.1 10154.6 10161.3 10174.6 10225.7 5257.6 5270.6 5272.0 5293.4 5302.5 4151.8 4573.4 4630.9 4654.5 4840.7 3910.3 3942.2 4017.1 4055.1 4066.4 1208.6 1209.9 1210.3 1221.4 1242.5 947.7 964.6 971.7 978.7 982.4 5592.7 5694.8 5707.8 5738.6 5797.0 1042.9 1086.2 1086.2 1090.5 1104.6 3916.9 4076.5 4091.7 4150.8 4151.7 10538.0 10872.8 10897.8 10925.2 10955.9 10815.8 10865.3 10871.3 10873.1 10892.6 7655.4 7870.3 7956.0 7963.4 8073.2 6069.9 6185.3 6225.7 6259.9 6346.1 9961.3 9985.1 9988.5 10146.0 10167.9 10086.7 10235.4 10258.0 10279.4 10335.5 6717.7 7269.1 7388.6 7621.7 7813.7 8130.0 8148.6 8164.3 8189.1 8201.3 7195.9 7362.6 7423.5 7460.9 7480.4 7048.9 7236.2 7395.7 7581.4 7638.3 7051.9 7074.0 7095.3 7120.4 7128.6 5026.2 5094.0 5136.6 5163.2 5196.0 5253.7 5254.4 5302.2 5337.0 5416.6 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#4] prototype.html Cycles:180 Average:4987.24 Median:5650.69 stddev:1478.41 (26.2%) stddev-sans-first:1440.64 07:55:46 INFO - PROCESS | 5066 | Values: 329.6 334.1 334.3 338.8 340.5 5603.3 5625.6 5642.8 5650.2 5681.3 5590.4 5628.1 5630.0 5651.2 5664.9 4185.7 4284.4 4377.3 4404.0 4413.9 4351.7 4390.8 4392.5 4393.4 4425.6 4367.8 4386.8 4391.7 4397.0 4412.1 4313.8 4375.6 4389.6 4394.3 4399.1 3854.2 3876.0 3881.6 3888.6 3900.5 5544.4 5545.1 5545.8 5557.5 5558.5 4702.5 4969.8 4980.2 4982.0 4992.5 5858.7 5883.0 5900.4 5930.9 5947.9 4133.9 4174.9 4175.1 4183.6 4185.9 5910.8 6017.2 6035.8 6081.4 6111.9 4276.7 4280.0 4281.0 4287.5 4293.2 4356.5 4364.2 4368.9 4371.4 4376.9 4865.8 4892.0 4930.8 4931.4 4953.5 5927.0 5937.5 5971.9 5975.9 6004.8 1481.0 1492.6 1493.6 1493.8 1496.9 981.2 1005.9 1014.7 1029.7 1031.4 5437.9 5641.6 5652.6 5665.5 5669.3 6012.3 6028.2 6079.3 6089.8 6093.5 5474.3 5695.2 5745.7 5784.1 5784.3 3222.1 3264.2 3269.5 3274.9 3280.9 6245.1 6306.6 6358.6 6359.9 6370.0 6203.8 6241.2 6276.9 6288.2 6289.5 6072.7 6291.0 6318.3 6346.8 6369.6 6086.8 6102.4 6109.8 6160.2 6169.7 5998.9 6003.5 6026.9 6034.2 6077.1 5916.5 6244.9 6265.0 6265.5 6324.4 4312.9 4318.0 4347.4 4355.5 4369.4 5877.6 6173.0 6201.6 6207.8 6212.2 5940.3 5990.6 6016.4 6025.2 6027.8 5972.7 5979.5 5983.0 5986.9 6011.7 5592.6 5828.6 5856.3 5866.3 5902.1 5929.2 5981.3 5986.8 6025.0 6035.0 5633.9 5799.4 5874.6 5911.4 5912.7 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - PROCESS | 5066 | [#5] yui.html Cycles:180 Average:21905.55 Median:4547.22 stddev:31489.05 (692.5%) stddev-sans-first:31537.32 07:55:46 INFO - PROCESS | 5066 | Values: 752.4 767.5 780.3 792.1 887.7 14692.3 15755.9 15808.6 15813.3 15862.4 15094.5 15250.0 15256.0 15334.5 15512.6 820.2 838.1 838.7 840.6 841.9 796.4 829.2 829.5 831.9 832.5 870.6 872.1 872.3 873.0 874.1 855.3 856.2 856.3 857.0 859.2 630.9 631.7 634.0 635.8 638.2 14467.7 14485.9 14539.2 14570.9 14574.4 15063.5 15450.2 15461.1 15495.6 15543.7 12200.6 12442.3 12512.2 12542.4 12686.6 3900.8 3926.3 3938.6 3996.2 4083.4 77095.0 79475.2 79886.0 81206.0 82083.6 11835.8 11984.4 12034.9 12124.0 12237.3 22314.1 22334.9 22420.2 22435.6 22697.3 9050.9 9063.4 9120.5 9134.2 9181.4 5055.3 5067.6 5088.7 5148.3 5316.0 3647.4 3742.9 3757.0 3771.9 3779.0 630.9 639.2 647.2 652.7 655.4 637.6 727.6 763.8 779.0 811.1 9800.5 9908.8 9937.4 10230.8 10242.7 599.5 715.9 733.4 765.3 772.5 5011.0 5094.4 5129.2 5133.4 5162.1 100219.0 121074.4 121777.0 122424.0 123579.0 79582.6 107850.0 108308.0 108454.5 108753.0 92695.5 93192.5 93906.0 95676.5 96566.5 9402.4 9535.0 9631.6 9710.8 9792.4 54351.7 54781.7 55010.0 55260.0 56601.0 67744.0 74490.0 83766.0 84211.0 85777.0 13455.4 13523.9 14312.4 14339.3 14626.0 15185.5 15211.5 15277.8 15446.2 15791.0 14941.8 15037.3 15047.6 15099.5 15128.5 13822.6 14209.9 14398.1 14688.9 14913.4 14495.0 14870.9 14949.6 15103.2 15532.8 12228.3 12244.3 12267.0 12323.1 12443.4 11248.2 11616.5 11754.4 12103.0 12610.8 07:55:46 INFO - PROCESS | 5066 | -------- Summary: end -------- 07:55:46 INFO - PROCESS | 5066 | 07:55:46 INFO - TEST-INFO | 5066: exit 0 07:55:46 INFO - TEST-OK | dromaeo_css | took 1109888ms 07:55:46 INFO - TEST-START | kraken 07:55:46 INFO - operating with platform_type : linux_ 07:55:46 INFO - Initialising browser for kraken test... 07:55:46 INFO - TEST-INFO | started process 5308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfoggxH/profile http://localhost:51388/getInfo.html) 07:55:51 INFO - PROCESS | 5308 | __metrics Screen width/height:1600/1200 07:55:51 INFO - PROCESS | 5308 | colorDepth:24 07:55:51 INFO - PROCESS | 5308 | Browser inner width/height: 1024/697 07:55:51 INFO - PROCESS | 5308 | __metrics 07:55:51 ERROR - PROCESS | 5308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:55:52 INFO - TEST-INFO | 5308: exit 0 07:55:52 INFO - Browser initialized. 07:55:52 INFO - Running cycle 1/1 for kraken test... 07:55:52 INFO - TEST-INFO | started process 5432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfoggxH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:04 INFO - PROCESS | 5432 | RSS: Main: 167321600 07:56:04 INFO - PROCESS | 5432 | 07:56:07 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51388/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:07 INFO - PROCESS | 5432 | RSS: Main: 172814336 07:56:07 INFO - PROCESS | 5432 | 07:56:10 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51388/tests/kraken/driver.html?testName=audio-dft) 07:56:11 INFO - PROCESS | 5432 | RSS: Main: 171954176 07:56:11 INFO - PROCESS | 5432 | 07:56:14 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51388/tests/kraken/driver.html?testName=audio-fft) 07:56:14 INFO - PROCESS | 5432 | RSS: Main: 166907904 07:56:14 INFO - PROCESS | 5432 | 07:56:16 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51388/tests/kraken/driver.html?testName=audio-oscillator) 07:56:17 INFO - PROCESS | 5432 | RSS: Main: 167763968 07:56:17 INFO - PROCESS | 5432 | 07:56:19 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:20 INFO - PROCESS | 5432 | RSS: Main: 168235008 07:56:20 INFO - PROCESS | 5432 | 07:56:23 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51388/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:23 INFO - PROCESS | 5432 | RSS: Main: 167866368 07:56:23 INFO - PROCESS | 5432 | 07:56:27 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51388/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:27 INFO - PROCESS | 5432 | RSS: Main: 168964096 07:56:27 INFO - PROCESS | 5432 | 07:56:30 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51388/tests/kraken/driver.html?testName=json-parse-financial) 07:56:31 INFO - PROCESS | 5432 | RSS: Main: 168390656 07:56:31 INFO - PROCESS | 5432 | 07:56:33 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:33 INFO - PROCESS | 5432 | RSS: Main: 168783872 07:56:33 INFO - PROCESS | 5432 | 07:56:35 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:36 INFO - PROCESS | 5432 | RSS: Main: 168726528 07:56:36 INFO - PROCESS | 5432 | 07:56:38 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:38 INFO - PROCESS | 5432 | RSS: Main: 168890368 07:56:38 INFO - PROCESS | 5432 | 07:56:41 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:42 INFO - PROCESS | 5432 | RSS: Main: 169086976 07:56:42 INFO - PROCESS | 5432 | 07:56:44 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:45 INFO - PROCESS | 5432 | RSS: Main: 168861696 07:56:45 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | Cycle 1(1): loaded http://localhost:51388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51388/tests/kraken/driver.html?testName=ai-astar) 07:56:47 INFO - PROCESS | 5432 | RSS: Main: 169541632 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | __start_tp_report 07:56:47 INFO - PROCESS | 5432 | _x_x_mozilla_page_load 07:56:47 INFO - PROCESS | 5432 | _x_x_mozilla_page_load_details 07:56:47 INFO - PROCESS | 5432 | |i|pagename|runs| 07:56:47 INFO - PROCESS | 5432 | |0;ai-astar;101;114;106;112;114;112;113;111;111;112 07:56:47 INFO - PROCESS | 5432 | |1;audio-beat-detection;144;118;146;171;119;148;154;118;187;122 07:56:47 INFO - PROCESS | 5432 | |2;audio-dft;161;160;161;161;161;163;169;170;163;164 07:56:47 INFO - PROCESS | 5432 | |3;audio-fft;75;75;74;147;78;76;78;83;184;76 07:56:47 INFO - PROCESS | 5432 | |4;audio-oscillator;85;83;146;84;83;83;142;84;86;146 07:56:47 INFO - PROCESS | 5432 | |5;imaging-gaussian-blur;118;117;117;117;119;117;117;118;117;118 07:56:47 INFO - PROCESS | 5432 | |6;imaging-darkroom;146;146;147;147;146;146;146;147;147;147 07:56:47 INFO - PROCESS | 5432 | |7;imaging-desaturate;95;96;95;96;96;95;96;100;97;95 07:56:47 INFO - PROCESS | 5432 | |8;json-parse-financial;54;53;54;55;56;55;54;57;54;54 07:56:47 INFO - PROCESS | 5432 | |9;json-stringify-tinderbox;62;62;62;63;62;62;63;62;64;63 07:56:47 INFO - PROCESS | 5432 | |10;stanford-crypto-aes;77;82;81;77;76;76;75;76;87;76 07:56:47 INFO - PROCESS | 5432 | |11;stanford-crypto-ccm;122;131;122;120;127;128;127;120;152;128 07:56:47 INFO - PROCESS | 5432 | |12;stanford-crypto-pbkdf2;161;157;160;164;155;157;156;157;155;155 07:56:47 INFO - PROCESS | 5432 | |13;stanford-crypto-sha256-iterative;64;63;65;63;64;63;65;63;63;63 07:56:47 INFO - PROCESS | 5432 | __end_tp_report 07:56:47 INFO - PROCESS | 5432 | __start_cc_report 07:56:47 INFO - PROCESS | 5432 | _x_x_mozilla_cycle_collect,963 07:56:47 INFO - PROCESS | 5432 | __end_cc_report 07:56:47 INFO - PROCESS | 5432 | __startTimestamp1468594607259__endTimestamp 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | ------- Summary: start ------- 07:56:47 INFO - PROCESS | 5432 | Number of tests: 14 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:4.06 (3.6%) stddev-sans-first:2.40 07:56:47 INFO - PROCESS | 5432 | Values: 101.0 114.0 106.0 112.0 114.0 112.0 113.0 111.0 111.0 112.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:147.00 stddev:23.90 (16.3%) stddev-sans-first:25.35 07:56:47 INFO - PROCESS | 5432 | Values: 144.0 118.0 146.0 171.0 119.0 148.0 154.0 118.0 187.0 122.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:3.50 (2.1%) stddev-sans-first:3.61 07:56:47 INFO - PROCESS | 5432 | Values: 161.0 160.0 161.0 161.0 161.0 163.0 169.0 170.0 163.0 164.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:38.45 (50.6%) stddev-sans-first:40.13 07:56:47 INFO - PROCESS | 5432 | Values: 75.0 75.0 74.0 147.0 78.0 76.0 78.0 83.0 184.0 76.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:83.50 stddev:29.34 (35.1%) stddev-sans-first:30.45 07:56:47 INFO - PROCESS | 5432 | Values: 85.0 83.0 146.0 84.0 83.0 83.0 142.0 84.0 86.0 146.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:56:47 INFO - PROCESS | 5432 | Values: 118.0 117.0 117.0 117.0 119.0 117.0 117.0 118.0 117.0 118.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:56:47 INFO - PROCESS | 5432 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 147.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 07:56:47 INFO - PROCESS | 5432 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 100.0 97.0 95.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.17 (2.2%) stddev-sans-first:1.22 07:56:47 INFO - PROCESS | 5432 | Values: 54.0 53.0 54.0 55.0 56.0 55.0 54.0 57.0 54.0 54.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 07:56:47 INFO - PROCESS | 5432 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 64.0 63.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.00 stddev:3.83 (5.0%) stddev-sans-first:4.03 07:56:47 INFO - PROCESS | 5432 | Values: 77.0 82.0 81.0 77.0 76.0 76.0 75.0 76.0 87.0 76.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:9.35 (7.3%) stddev-sans-first:9.68 07:56:47 INFO - PROCESS | 5432 | Values: 122.0 131.0 122.0 120.0 127.0 128.0 127.0 120.0 152.0 128.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.00 stddev:3.02 (1.9%) stddev-sans-first:2.96 07:56:47 INFO - PROCESS | 5432 | Values: 161.0 157.0 160.0 164.0 155.0 157.0 156.0 157.0 155.0 155.0 07:56:47 INFO - PROCESS | 5432 | 07:56:47 INFO - PROCESS | 5432 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 07:56:47 INFO - PROCESS | 5432 | Values: 64.0 63.0 65.0 63.0 64.0 63.0 65.0 63.0 63.0 63.0 07:56:47 INFO - PROCESS | 5432 | -------- Summary: end -------- 07:56:47 INFO - PROCESS | 5432 | 07:56:48 INFO - TEST-INFO | 5432: exit 0 07:56:48 INFO - TEST-OK | kraken | took 61341ms 07:56:48 INFO - SUITE-END | took 1171s 07:56:48 INFO - Completed test suite (00:19:31) 07:56:48 INFO - javascript benchmark 07:56:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7496.034490714393, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.2160749009004, 3119.797213181143, 3126.1403114143595, 3126.1559378967663, 3127.6403213630424, 5484.204790305404, 5554.888902221958, 5587.580931430139, 5593.356763972144, 5601.719914004294, 5497.202905578689, 5502.477264659851, 5536.446355364462, 5609.691466969315, 5617.662940223589, 4971.925421118686, 5030.471800460936, 5134.358205224347, 5183.041137389595, 5215.191645294985, 493.3196300102774, 4939.036887806879, 4995.725235112068, 5035.118854200518, 5088.898222035557, 5007.874803129915, 5033.748312584375, 5049.368828896388, 5052.191649336107, 5055.11535481293, 5060.974695126501, 5065.037642847848, 5081.669691470042, 5082.695038297677, 5102.209157580581, 4891.5353041461, 4897.363342765453, 4903.681260718042, 4928.162212423897, 4928.26076088586, 5388.164834450667, 5404.7838086476495, 5460.34475862899, 5461.69960652164, 5475.0418676731415, 5728.112142617901, 5818.883622327529, 5822.7088645567555, 5825.38833422493, 5855.0, 5934.080217566241, 5936.990711579042, 5954.642721436684, 5987.0, 6035.909461358083, 5512.39363669996, 5514.255575497296, 5528.75120619573, 5543.805966791143, 5573.024720673907, 5849.649021058665, 5905.261842269716, 6095.512359011268, 6097.512199024068, 6098.634081955097, 5695.857603559944, 5705.0, 5731.484166425042, 5738.196652468658, 5744.798932037442, 5795.913061304083, 5798.449147330997, 5802.82591522255, 5814.709264536757, 5823.4467725566, 5717.599768016199, 5784.363719990798, 5799.623024503394, 5846.064629659234, 5863.120531920246, 5897.557683173779, 5906.8818623627285, 5918.437748413894, 5955.493783028491, 5961.344252132262, 4516.277395616686, 4527.886802829956, 4529.592336689648, 4534.047849951481, 4535.548152965537, 3898.688104951597, 3983.50206224222, 4009.8797036088963, 4030.6573941214738, 4035.7780322082567, 5568.443155684399, 5572.665640061609, 5583.776648933997, 5611.158326251013, 5686.289213848269, 5938.465538101592, 5996.760129594767, 5997.040473524303, 6000.429959153874, 6008.519318454513, 5517.806876759294, 5523.834284971457, 5550.306211723535, 5554.222408862763, 5567.192757050286, 5019.121653710586, 5038.0, 5059.443461219263, 5067.366579177603, 5102.36220472441, 5972.492338151305, 6046.637201767908, 6056.424639659225, 6060.939390606126, 6068.0, 5898.8230353089475, 5951.7024148791525, 5959.344472107978, 5997.790077347447, 6001.039833626599, 6097.542684298606, 6117.296510901126, 6117.327094019565, 6146.692665366624, 6177.289611694533, 5675.460831221028, 5839.0, 5847.502962248256, 5873.471387575139, 5894.440028197314, 5820.330661973927, 5841.32824725162, 5856.443637854397, 5877.324107727666, 5879.029960056543, 5667.518260947701, 5692.857678558069, 5706.001449746194, 5746.770129194785, 5754.280714910637, 5648.350439699487, 5679.574031947538, 5695.373508914099, 5724.3703192647945, 5753.712314384347, 5723.771049158154, 5739.799107031234, 5760.423957604206, 5803.390643982321, 5826.796062137805, 5749.540036796962, 5776.884462310646, 5806.158107074366, 5818.0981947798155, 5823.213866128188, 5487.725613719218, 5648.830535083954, 5684.232628595252, 5737.540996720169, 5751.1085781703905], "value": 5395.75403914557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.6254556736213, 584.339696143358, 590.0382376725936, 614.2598169206107, 622.8536293970919, 41458.0, 46138.0, 46146.53853461464, 46221.0, 46225.0, 45370.77314613431, 46021.76989115058, 46096.5427592931, 46172.307415388714, 46211.76894115525, 8912.376133670645, 9041.638334466614, 9069.727908162766, 9072.228860546862, 9084.0, 8977.640894364251, 9027.909720902773, 9075.047120052399, 9076.727698169065, 9078.137576930214, 9084.77288067797, 9140.725778226664, 9140.908590914072, 9143.817123657524, 9166.587503562323, 9097.363184577081, 9132.452052876848, 9139.862902056475, 9151.359404841663, 9158.67944621935, 9054.864177037283, 9079.954600226956, 9122.22461090808, 9128.406653567497, 9129.132732390412, 33704.15739606505, 43670.56329436697, 43819.78090109561, 43997.34003989943, 44096.55903440957, 3516.7186625069935, 3534.32847758925, 3582.4805403216387, 3670.302642497917, 3983.8406463741417, 32590.674093259, 32928.506072408934, 33044.83477582597, 33105.0, 33183.336333273444, 4304.9139017219795, 4359.38968544404, 4370.475542934836, 4398.73607583546, 4417.072414792898, 336810.0, 337814.0, 338648.99999999756, 339107.0, 340759.0, 36343.0, 36718.632813672055, 36720.0, 36725.0, 36776.632233677854, 36891.81554092266, 37689.81155094207, 37744.24511509809, 37887.81056094702, 39675.603243967766, 17461.126943652765, 17500.21249043796, 17519.38682146144, 17524.47426577205, 17614.823851761575, 13313.800292995613, 13385.464581416634, 13457.327133643279, 13480.730385392237, 13483.460661573623, 20472.385828425173, 20555.486112847, 20631.0, 20654.277100301417, 20697.68953465699, 7234.312740289664, 7351.191368949411, 7628.694852205849, 7672.0, 7803.141654418009, 945.4825005865487, 1079.0773888325525, 1108.3460758152728, 1143.108375467137, 1209.9274043557239, 34271.65728342735, 34345.65654343425, 34415.13962150916, 34700.47949280763, 34925.30149396998, 1142.7485953090472, 1155.4684844971407, 1170.5083864776814, 1187.6140254417348, 1190.7380376317196, 17184.82815171857, 18199.818001820076, 18205.27178912829, 18309.908450457664, 18329.0, 618844.0, 625925.0, 627511.0, 632780.0, 634220.0, 62977.68511157415, 63125.0, 63416.36583634104, 63596.68201658962, 63777.68111159507, 1321.722438287951, 1373.7252549490142, 1390.2701081931864, 1399.762040453105, 1405.100735529262, 32888.835555822065, 33664.49503257502, 33742.0, 33825.323493530486, 34390.656093438745, 53844.0, 54909.450905490434, 55020.44979550153, 55235.44764552303, 55251.17123243235, 507842.0, 511189.0, 513035.0, 515253.0, 515345.0, 29233.0, 29591.556126657688, 29746.702532975258, 29788.0, 29845.10464686063, 51355.48644513507, 51532.74233628808, 52885.0, 53083.20375194298, 54023.729881350344, 43409.488576713746, 44070.559294406645, 44195.337069943336, 44740.77629611831, 44869.775651121534, 43986.56013439825, 44067.33898991582, 44166.55833441753, 45094.77452612716, 45744.0, 43922.34116488319, 44070.77964610157, 44731.552684472736, 44866.77566612146, 45968.31047534357, 37954.2409151821, 38949.6105038946, 39547.40678889876, 40583.7970810144, 40720.3891941627, 29416.852915735286, 29528.11415657534, 30952.380952381278, 31418.371632566763, 31828.681713183498], "value": 20608.86730687085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3792275475109, 385.0470086535824, 393.76374175494726, 400.9498812648419, 417.53444908926537, 19068.809311906876, 19646.607067858633, 20311.0, 20704.99999999998, 20707.275245366414, 19746.407607771755, 19855.801441985575, 19936.302229421974, 20404.591908161827, 20482.590348193025, 5684.317881854184, 5689.345725241609, 5940.821775346746, 5990.970045149768, 6087.847803804896, 5963.970180149115, 5970.044792833148, 6004.5796794224425, 6017.729202185912, 6022.337542870303, 6100.877982440348, 6189.0, 6195.349488303731, 6205.069239614071, 6209.068639704058, 6505.674716264168, 6715.093462382565, 6804.319568043181, 6815.965920170417, 6896.896546551806, 5858.970705146489, 6074.453299203093, 6075.422834830684, 6082.665453400061, 6093.086037094471, 13911.165330080228, 14419.495317663936, 14422.855771442257, 14660.120392776467, 14908.552743417606, 2326.4998025424616, 2378.5361854438393, 2414.155045733979, 2940.8088474249107, 3030.8939187128344, 10585.15318774504, 10624.256302058859, 10786.08318292946, 10819.242653014293, 10863.18526110545, 1963.882167069966, 2013.3054096336887, 2023.6458619741634, 2036.4908772806798, 2064.95870082599, 74766.62616686936, 82403.17596824015, 83777.0, 90820.09179908248, 91059.08940910573, 11185.496652650487, 11348.865113488586, 11510.7410258205, 11601.12991525639, 11896.22674526153, 16119.597010074607, 16125.193740312938, 16204.75692864608, 16212.0, 16248.75626865598, 8494.320454363637, 8643.56782160902, 8685.218330350172, 8708.303335733126, 8741.0, 8227.259546640711, 8297.211764882326, 8299.8340033199, 8327.916720832834, 8447.029895948894, 4853.199222128309, 4934.777934992934, 4956.628252880976, 5000.849974500771, 5001.57486613642, 2025.868318559289, 2052.415061707436, 2092.853500254998, 2130.2863540713724, 2132.093860109447, 982.1210017034714, 995.8257304971601, 998.8801343838786, 1088.080571916729, 1142.2689478733616, 20069.0, 20637.484062898246, 20716.792832071485, 20768.273110441365, 20915.581688366452, 974.288769198489, 1042.4579218806177, 1054.5887104029434, 1068.8183008888507, 1086.9619513364876, 10951.853735898663, 11423.600173993871, 11488.080953523699, 11511.539538418538, 11554.480048397842, 525158.0, 525493.0, 529394.0, 531696.0, 532032.0, 98399.50800245952, 99538.502307488, 101476.0, 103458.48270758598, 107663.46168269265, 1023.9539220735085, 1036.5957276662107, 1073.5383784972537, 1074.790415868898, 1078.8746170045, 14418.495352662607, 15514.146721930401, 17773.911130444267, 17976.460706178834, 18237.54406139857, 43246.0, 44926.32610510779, 45536.54463455456, 45578.316325254484, 46603.53396465992, 67510.0, 67697.0, 68129.65935170293, 68170.0, 68796.31203688099, 7774.416918731004, 8078.030636323679, 8082.515049097073, 8257.05043919957, 8885.200331970154, 12825.615231543068, 14068.718625627635, 14278.143311401349, 14583.562493125222, 14898.702025959637, 12254.693632659255, 12450.25298482094, 12499.312537810507, 12514.31171285588, 12818.55135070268, 12156.574519891761, 12228.938855305667, 12293.44679489443, 12414.62756117318, 12967.481300747864, 12439.689007774878, 12441.626751197478, 12841.101122921305, 12871.22772633645, 13013.739725205254, 9135.31485138604, 9184.678536251198, 9241.260699143917, 9390.76523086901, 9487.098725621056, 11903.0, 12170.208936419105, 12244.816327755269, 12324.383780811102, 12602.117851750656], "value": 9642.50940068261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.9999999999998, 1412.675084730512, 1434.6700258940443, 1767.5404394857333, 1790.4002159276633, 7572.394208463324, 8248.17518248175, 8258.83482330353, 8806.559672016405, 8810.823783524325, 8331.250187483125, 8559.27246184075, 8598.785030374229, 8653.30773538117, 8693.73918782436, 2309.711286089235, 2346.8591884486987, 2353.9176128835493, 2354.2466410748566, 2363.89362478688, 2320.8143348532076, 2333.3583264602285, 2352.623580227164, 2364.207990323244, 2370.442945907719, 2313.9884300578556, 2335.2293743064747, 2340.8127349811975, 2352.2707960532202, 2362.574736547421, 2321.1875843454823, 2326.720793504773, 2333.2416964486524, 2334.568104900599, 2336.754640762721, 2290.061074959259, 2295.2081531871477, 2296.3799774061076, 2306.1467257114973, 2306.8269879759087, 8651.264642505395, 8690.782730431727, 8715.69495067676, 8764.956175219084, 8766.035736069027, 5029.622778291643, 5128.487151284879, 5136.871578210575, 5171.3277273954145, 5180.067587834188, 3323.4350160472777, 3424.366492198951, 3452.879149229765, 3462.0745470077745, 3537.620328072054, 1218.6405010521828, 1276.2151276964694, 1307.627326212025, 1312.1536608887309, 1334.0194956706812, 11924.582639607659, 11980.221285616493, 12034.458449369711, 12053.276803391824, 12053.758924821455, 4435.1351486459835, 4542.409486766699, 4656.697314674535, 4686.625069994392, 4694.0, 10148.137408320375, 10154.593816247416, 10161.288709790391, 10174.643887464052, 10225.744356391, 5257.579393648499, 5270.604704647167, 5272.0, 5293.417724050351, 5302.549283310962, 4151.7924103794685, 4573.428321459817, 4630.884227894329, 4654.511276315938, 4840.685355451885, 3910.3156947534635, 3942.211557688474, 4017.0760725032824, 4055.1281474483126, 4066.4103704962613, 1208.601161616682, 1209.9455524501418, 1210.3222195570509, 1221.3893053473264, 1242.521629172757, 947.6541062512272, 964.6430820596424, 971.718201721507, 978.6966040527459, 982.3565564555084, 5592.664440133605, 5694.829155125353, 5707.771689132472, 5738.626989245686, 5797.01450753373, 1042.8696412948382, 1086.1528008153653, 1086.179934149712, 1090.4983707494482, 1104.5526561742347, 3916.8824935251987, 4076.510818701775, 4091.7026875114957, 4150.750954942713, 4151.6886233532605, 10538.0, 10872.836907446395, 10897.782044359226, 10925.235233533735, 10955.945220273848, 10815.78368432627, 10865.293755905841, 10871.29336593119, 10873.075788557902, 10892.564297428014, 7655.425843061793, 7870.331021863091, 7956.0, 7963.442559020813, 8073.19268073188, 6069.878602427839, 6185.2886918003205, 6225.688715564113, 6259.874802503833, 6346.079818426395, 9961.252906032221, 9985.101340879355, 9988.500574971367, 10146.036126567964, 10167.898321016992, 10086.747831304276, 10235.437050962268, 10258.0, 10279.383237005804, 10335.483225838527, 6717.697703603448, 7269.091363579552, 7388.556686598821, 7621.69513219465, 7813.687452501837, 8130.0, 8148.592570371339, 8164.306033987177, 8189.140140285184, 8201.343892488705, 7195.8560828784175, 7362.595057271901, 7423.517471364344, 7460.888086678596, 7480.3641690456925, 7048.859022819617, 7236.167840698387, 7395.667194976347, 7581.431392645684, 7638.312551870358, 7051.858962820817, 7073.964630176816, 7095.254998225112, 7120.359167674934, 7128.643567821692, 5026.246063090565, 5093.974530127474, 5136.563392111712, 5163.173892177234, 5196.0, 5253.684778913277, 5254.369475662945, 5302.212158160661, 5336.973315133399, 5416.620836541404], "value": 4630.856646178697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.581431581891, 334.07461332110057, 334.3179912977526, 338.7747148146483, 340.4688685650386, 5603.327600687918, 5625.578081643877, 5642.7742890284335, 5650.208970744094, 5681.3466451358, 5590.413006634306, 5628.0713682242385, 5630.0, 5651.180578816069, 5664.943350566493, 4185.6651467882575, 4284.378765079062, 4377.321515165155, 4404.0, 4413.867583972486, 4351.6953813233085, 4390.792532053679, 4392.472903251598, 4393.428854248943, 4425.645948324126, 4367.825286988516, 4386.802593883267, 4391.736495810245, 4396.955415731684, 4412.1175764847, 4313.849015284466, 4375.621679171083, 4389.561043895616, 4394.318880573516, 4399.142167277382, 3854.1520865409566, 3876.0, 3881.5536213335545, 3888.6111388860886, 3900.4734360861203, 5544.362398324204, 5545.085060964936, 5545.77816887324, 5557.527610153142, 5558.527525160366, 4702.5297470253045, 4969.763606377109, 4980.153373926441, 4981.9750901245625, 4992.500749924979, 5858.744383412374, 5882.970585147047, 5900.409959004065, 5930.911036334458, 5947.881042379128, 4133.875983720493, 4174.853880114212, 4175.123224122938, 4183.581641835823, 4185.895352616179, 5910.822675319747, 6017.187679663233, 6035.849103772397, 6081.385004448086, 6111.908321375183, 4276.743395396286, 4279.957200428018, 4280.978595107067, 4287.506936702319, 4293.248681480728, 4356.451475886642, 4364.1708075466195, 4368.890777730582, 4371.409859668967, 4376.890577735582, 4865.783554111472, 4891.9755401222765, 4930.778114984834, 4931.446594322777, 4953.455119936804, 5926.970365148233, 5937.456261371988, 5971.940280597225, 5975.940240597625, 6004.789832355847, 1480.9629759256104, 1492.6268432891777, 1493.6191271225769, 1493.8431464696268, 1496.8503149684943, 981.2003217377815, 1005.894381089975, 1014.6905193915926, 1029.7322696099068, 1031.3657100882904, 5437.858049809505, 5641.605087643908, 5652.6325788824415, 5665.49010589049, 5669.348024977098, 6012.338642749294, 6028.156058151862, 6079.270487541523, 6089.756409743649, 6093.512518998469, 5474.288342515448, 5695.202671625976, 5745.741441635137, 5784.1034639630925, 5784.2769653793275, 3222.050659351059, 3264.249222678797, 3269.5095735639843, 3274.9192766387036, 3280.8851690190727, 6245.125682404467, 6306.621602703853, 6358.554901156875, 6359.904601430982, 6369.9681501592195, 6203.7828675996125, 6241.157443745127, 6276.897239424752, 6288.213973253343, 6289.465395441439, 6072.696365181635, 6290.968545157337, 6318.273398559132, 6346.777862774781, 6369.649669268142, 6086.817395478142, 6102.359252278625, 6109.816705498843, 6160.229971253593, 6169.691515424301, 5998.910016349845, 6003.519718422428, 6026.8794624106395, 6034.2155519782145, 6077.149199112217, 5916.467517923407, 6244.875102497834, 6264.9976003839165, 6265.464961084564, 6324.367563243823, 4312.900210446316, 4317.956820431756, 4347.434833471629, 4355.5426680198125, 4369.3664418659755, 5877.647341159544, 6172.969135154295, 6201.627902325875, 6207.81376558704, 6212.161358216583, 5940.257467816523, 5990.64056156632, 6016.398360163948, 6025.216721826135, 6027.819165425044, 5972.70136493165, 5979.521638269015, 5983.0, 5986.880262394815, 6011.6693581853415, 5592.636478628876, 5828.59199856006, 5856.267966504187, 5866.325372582208, 5902.1146827976145, 5929.1995580597795, 5981.312149102909, 5986.844735895162, 6024.969875150597, 6035.021107586346, 5633.8591535211945, 5799.420057994335, 5874.647521148745, 5911.408859114054, 5912.674802885883], "value": 4510.384948100455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.3830459023603, 767.5471471831622, 780.2587541835258, 792.0930534537954, 887.7159309021114, 14692.338844751985, 15755.921220393911, 15808.604784880385, 15813.288402021908, 15862.444814431497, 15094.54716358511, 15250.0, 15256.0, 15334.539963801077, 15512.612184695388, 820.2044017303207, 838.1074156023845, 838.6687258532907, 840.5503055865113, 841.8653015517518, 796.41861441148, 829.2495291760966, 829.4691397505601, 831.8710599857031, 832.5296207642692, 870.5951732444412, 872.1322284327103, 872.3457406944791, 872.9694460693877, 874.0647507167333, 855.3328403845011, 856.1823458597025, 856.2678909532353, 856.9657213711444, 859.1537335724306, 630.9432151106422, 631.7125707802938, 633.9887878833254, 635.8378613453586, 638.1990601794764, 14467.710645787025, 14485.927570362186, 14539.200343981076, 14570.92714536431, 14574.417023319054, 15063.54809355721, 15450.1502417367, 15461.149636769973, 15495.612609684735, 15543.689126217525, 12200.572979945659, 12442.315672638002, 12512.186707863959, 12542.435590398363, 12686.555970540987, 3900.843966241347, 3926.3128952433494, 3938.5667576566557, 3996.200759848042, 4083.448734420845, 77095.0, 79475.20524794793, 79886.0, 81206.0, 82083.5895820523, 11835.763284734257, 11984.400779960966, 12034.939825300993, 12124.0, 12237.265764054007, 22314.10743570239, 22334.888325558593, 22420.215292464687, 22435.55128897413, 22697.319080427613, 9050.909490905007, 9063.365564410427, 9120.543972801333, 9134.177923986874, 9181.357304988587, 5055.3428054353435, 5067.6452648315, 5088.6946783193125, 5148.33071700684, 5316.0, 3647.3617117004947, 3742.9438558421643, 3757.0231739747865, 3771.905702357463, 3779.0, 630.9400606942334, 639.1754636518931, 647.2233320015999, 652.6704014472756, 655.3937607712846, 637.6142433827561, 727.6070921702221, 763.8319569694659, 779.033997842671, 811.1158836867843, 9800.529920511837, 9908.801823963624, 9937.354071985297, 10230.795384092276, 10242.692719218436, 599.5353600959291, 715.8675645005691, 733.3839574757122, 765.3456294867808, 772.4554189296532, 5011.0, 5094.439611642716, 5129.230615407719, 5133.409657889316, 5162.1224391853475, 100219.0, 121074.39462802629, 121777.0, 122424.0, 123579.0, 79582.6020869892, 107850.0, 108308.0, 108454.45772771243, 108753.0, 92695.53652231695, 93192.53403733074, 93906.0, 95676.52161739147, 96566.51716741371, 9402.43585384879, 9534.995514984117, 9631.614735410505, 9710.805783884141, 9792.412455252708, 54351.72824135854, 54781.72609136929, 55010.0, 55260.0, 56601.0, 67744.0, 74490.0, 83766.0, 84211.0, 85777.0, 13455.394507247001, 13523.932380338036, 14312.355943982337, 14339.283035848375, 14626.0, 15185.544433667008, 15211.467598633995, 15277.77083343773, 15446.150461724263, 15791.0, 14941.77587336169, 15037.323320450387, 15047.623809404853, 15099.54701358961, 15128.470503532764, 13822.585322440344, 14209.928950355183, 14398.136111833324, 14688.853111468748, 14913.403463861325, 14495.0, 14870.925645372137, 14949.626259343604, 15103.244837757848, 15532.767008495108, 12228.327441990776, 12244.326562038817, 12267.0, 12323.137380383287, 12443.377831108228, 11248.217398193527, 11616.477258523555, 11754.412279386168, 12103.0, 12610.810837837624], "value": 7920.8958453930245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 106.0, 112.0, 114.0, 112.0, 113.0, 111.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 146.0, 171.0, 119.0, 148.0, 154.0, 118.0, 187.0, 122.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 169.0, 170.0, 163.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 147.0, 78.0, 76.0, 78.0, 83.0, 184.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 146.0, 84.0, 83.0, 83.0, 142.0, 84.0, 86.0, 146.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 100.0, 97.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 56.0, 55.0, 54.0, 57.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 64.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 81.0, 77.0, 76.0, 76.0, 75.0, 76.0, 87.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 122.0, 120.0, 127.0, 128.0, 127.0, 120.0, 152.0, 128.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 160.0, 164.0, 155.0, 157.0, 156.0, 157.0, 155.0, 155.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 65.0, 63.0, 63.0, 63.0], "value": 63.6, "unit": "score"}]}]} 07:56:48 INFO - Return code: 0 07:56:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:48 ERROR - # TBPL SUCCESS # 07:56:48 INFO - Running post-action listener: _resource_record_post_action 07:56:48 INFO - ##### 07:56:48 INFO - ##### Finished run-tests step (success) 07:56:48 INFO - ##### 07:56:48 INFO - Running post-run listener: _resource_record_post_run 07:56:48 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 339968; Write bytes: 371167232; Read time: 140; Write time: 244696 07:56:48 INFO - TinderboxPrint: CPU usage
13.3% 07:56:48 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 140 07:56:48 INFO - TinderboxPrint: I/O write bytes / time
371,167,232 / 244,696 07:56:48 INFO - TinderboxPrint: CPU idle
8,227.8 (86.7%) 07:56:48 INFO - TinderboxPrint: CPU user
1,207.2 (12.7%) 07:56:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74117120; Read time: 0; Write time: 38056 07:56:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 335872; Write bytes: 292560896; Read time: 120; Write time: 202672 07:56:49 INFO - Running post-run listener: _upload_blobber_files 07:56:49 INFO - Blob upload gear active. 07:56:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:49 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:56:49 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:56:49 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:56:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:50 INFO - (blobuploader) - INFO - Done attempting. 07:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:51 INFO - (blobuploader) - INFO - Done attempting. 07:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:55 INFO - (blobuploader) - INFO - Done attempting. 07:56:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:55 INFO - Return code: 0 07:56:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3a66e5b5c2d1f505cea6c8444c8298c85b4a10602087662044cb0a660a33937f90a2d29502fe621c8b0fac14c41ff8869509410e04a957c91b7b5bcf730ef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb450e9161f57e97cf7d56a7306f2b56ddec0cc0d3f4b24e737c73b81bc6e459cee44911d2d89e3c7fc30cfd78d92b7abbf0f1fdf5950dc138f8f4019c548bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb7d8e7a7090a7bcedc1c74c65fa6bc7f4552b4c8879b6b139672a622852da25fee2efe1b5043d709524b8fb0cf6da485c5dc9d776c90449f528e682b964744"} 07:56:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:55 INFO - Contents: 07:56:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3a66e5b5c2d1f505cea6c8444c8298c85b4a10602087662044cb0a660a33937f90a2d29502fe621c8b0fac14c41ff8869509410e04a957c91b7b5bcf730ef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb450e9161f57e97cf7d56a7306f2b56ddec0cc0d3f4b24e737c73b81bc6e459cee44911d2d89e3c7fc30cfd78d92b7abbf0f1fdf5950dc138f8f4019c548bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb7d8e7a7090a7bcedc1c74c65fa6bc7f4552b4c8879b6b139672a622852da25fee2efe1b5043d709524b8fb0cf6da485c5dc9d776c90449f528e682b964744"} 07:56:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:55 INFO - Copying logs to upload dir... 07:56:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.083992 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-15 07:56:55.858852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:55.862274) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 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/f3a66e5b5c2d1f505cea6c8444c8298c85b4a10602087662044cb0a660a33937f90a2d29502fe621c8b0fac14c41ff8869509410e04a957c91b7b5bcf730ef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb450e9161f57e97cf7d56a7306f2b56ddec0cc0d3f4b24e737c73b81bc6e459cee44911d2d89e3c7fc30cfd78d92b7abbf0f1fdf5950dc138f8f4019c548bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb7d8e7a7090a7bcedc1c74c65fa6bc7f4552b4c8879b6b139672a622852da25fee2efe1b5043d709524b8fb0cf6da485c5dc9d776c90449f528e682b964744"} 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.011249 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/f3a66e5b5c2d1f505cea6c8444c8298c85b4a10602087662044cb0a660a33937f90a2d29502fe621c8b0fac14c41ff8869509410e04a957c91b7b5bcf730ef71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb450e9161f57e97cf7d56a7306f2b56ddec0cc0d3f4b24e737c73b81bc6e459cee44911d2d89e3c7fc30cfd78d92b7abbf0f1fdf5950dc138f8f4019c548bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb7d8e7a7090a7bcedc1c74c65fa6bc7f4552b4c8879b6b139672a622852da25fee2efe1b5043d709524b8fb0cf6da485c5dc9d776c90449f528e682b964744"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:56:55.895584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-07-15 07:56:55.896330) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468592697.316894-205027124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 17.41 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-07-15 07:57:13.312567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:13.312872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:13.316674) ========= ========= Total master_lag: 17.55 =========