builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1468436725.06 results: success (0) buildid: 20160713103517 builduid: 3f9eda28bb27410a9b92a966bfe8eb5b revision: 412755b088952351ae0bb40384ec409367077f38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.055563) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.056004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.056277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.070695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.070979) ========= 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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 12:05:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.8M=0s 2016-07-13 12:05:25 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.166472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.166805) ========= 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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:25.216735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 12:05:25.217128) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 412755b088952351ae0bb40384ec409367077f38 --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 412755b088952351ae0bb40384ec409367077f38 --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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 12:05:25,939 truncating revision to first 12 chars 2016-07-13 12:05:25,939 Setting DEBUG logging. 2016-07-13 12:05:25,939 attempt 1/10 2016-07-13 12:05:25,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/412755b08895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 12:05:26,741 unpacking tar archive at: mozilla-central-412755b08895/testing/mozharness/ program finished with exit code 0 elapsedTime=1.126551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 12:05:26.357361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:26.357716) ========= script_repo_revision: 412755b088952351ae0bb40384ec409367077f38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:26.358095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:26.358362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 12:05:26.368839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 12:05:26.369107) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:27 INFO - MultiFileLogger online at 20160713 12:05:27 in /builds/slave/test 12:05:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:05:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:05:27 INFO - {'append_to_log': False, 12:05:27 INFO - 'base_work_dir': '/builds/slave/test', 12:05:27 INFO - 'blob_upload_branch': 'Firefox', 12:05:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:05:27 INFO - 'branch': 'Firefox', 12:05:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:27 INFO - 'config_files': ('talos/linux_config.py',), 12:05:27 INFO - 'default_actions': ('clobber', 12:05:27 INFO - 'read-buildbot-config', 12:05:27 INFO - 'download-and-extract', 12:05:27 INFO - 'populate-webroot', 12:05:27 INFO - 'create-virtualenv', 12:05:27 INFO - 'install', 12:05:27 INFO - 'run-tests'), 12:05:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:27 INFO - 'download_minidump_stackwalk': True, 12:05:27 INFO - 'download_symbols': 'ondemand', 12:05:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:05:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:05:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:05:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:05:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:27 INFO - 'installer_path': 'installer.exe', 12:05:27 INFO - 'log_level': 'info', 12:05:27 INFO - 'log_name': 'talos', 12:05:27 INFO - 'log_to_console': True, 12:05:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:27 INFO - 'opt_config_files': (), 12:05:27 INFO - 'pip_index': False, 12:05:27 INFO - 'sps_profile': False, 12:05:27 INFO - 'sps_profile_interval': 0, 12:05:27 INFO - 'suite': 'dromaeojs', 12:05:27 INFO - 'system_bits': '32', 12:05:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:27 INFO - 'title': 'talos-linux64-ix-056', 12:05:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:27 INFO - 'use_talos_json': True, 12:05:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:05:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:27 INFO - 'work_dir': 'build'} 12:05:27 INFO - ##### 12:05:27 INFO - ##### Running clobber step. 12:05:27 INFO - ##### 12:05:27 INFO - Running pre-action listener: _resource_record_pre_action 12:05:27 INFO - Running main action method: clobber 12:05:27 INFO - rmtree: /builds/slave/test/build 12:05:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:05:28 INFO - Running post-action listener: _resource_record_post_action 12:05:28 INFO - ##### 12:05:28 INFO - ##### Finished clobber step (success) 12:05:28 INFO - ##### 12:05:28 INFO - ##### 12:05:28 INFO - ##### Running read-buildbot-config step. 12:05:28 INFO - ##### 12:05:28 INFO - Running pre-action listener: _resource_record_pre_action 12:05:28 INFO - Running main action method: read_buildbot_config 12:05:28 INFO - Using buildbot properties: 12:05:28 INFO - { 12:05:28 INFO - "project": "", 12:05:28 INFO - "product": "firefox", 12:05:28 INFO - "script_repo_revision": "production", 12:05:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:05:28 INFO - "repository": "", 12:05:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:05:28 INFO - "buildid": "20160713103517", 12:05:28 INFO - "pgo_build": "True", 12:05:28 INFO - "basedir": "/builds/slave/test", 12:05:28 INFO - "buildnumber": 385, 12:05:28 INFO - "slavename": "talos-linux64-ix-056", 12:05:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:05:28 INFO - "platform": "ubuntu64_hw", 12:05:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:05:28 INFO - "branch": "mozilla-central", 12:05:28 INFO - "repo_path": "mozilla-central", 12:05:28 INFO - "revision": "412755b088952351ae0bb40384ec409367077f38", 12:05:28 INFO - "stage_platform": "linux64-pgo", 12:05:28 INFO - "builduid": "3f9eda28bb27410a9b92a966bfe8eb5b", 12:05:28 INFO - "slavebuilddir": "test" 12:05:28 INFO - } 12:05:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:05:28 INFO - Running post-action listener: _resource_record_post_action 12:05:28 INFO - ##### 12:05:28 INFO - ##### Finished read-buildbot-config step (success) 12:05:28 INFO - ##### 12:05:28 INFO - ##### 12:05:28 INFO - ##### Running download-and-extract step. 12:05:28 INFO - ##### 12:05:28 INFO - Running pre-action listener: _resource_record_pre_action 12:05:28 INFO - Running main action method: download_and_extract 12:05:28 INFO - mkdir: /builds/slave/test/build/tests 12:05:28 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')]} 12:05:28 INFO - https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:28 INFO - Downloaded 1361 bytes. 12:05:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:05:28 INFO - Using the following test package requirements: 12:05:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:05:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:05:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:05:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'jsshell-linux-x86_64.zip'], 12:05:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:05:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:05:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:05:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:05:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:05:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:05:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:05:28 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')]} 12:05:28 INFO - https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:30 INFO - Downloaded 24326474 bytes. 12:05:30 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'] 12:05:30 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 12:05:31 INFO - Return code: 0 12:05:31 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 12:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:31 INFO - https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:32 INFO - Downloaded 24326474 bytes. 12:05:32 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'] 12:05:32 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 12:05:33 INFO - Return code: 0 12:05: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')]} 12:05:33 INFO - https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:34 INFO - Downloaded 14403317 bytes. 12:05:34 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'] 12:05:34 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 12:05:35 INFO - Return code: 0 12:05: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')]} 12:05:35 INFO - https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/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 12:05:37 INFO - Downloaded 60813658 bytes. 12:05:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:05:37 INFO - mkdir: /builds/slave/test/properties 12:05:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:05:37 INFO - Writing to file /builds/slave/test/properties/build_url 12:05:37 INFO - Contents: 12:05:37 INFO - build_url:https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:05:37 INFO - Running post-action listener: _resource_record_post_action 12:05:37 INFO - Running post-action listener: set_extra_try_arguments 12:05:37 INFO - ##### 12:05:37 INFO - ##### Finished download-and-extract step (success) 12:05:37 INFO - ##### 12:05:37 INFO - ##### 12:05:37 INFO - ##### Running populate-webroot step. 12:05:37 INFO - ##### 12:05:37 INFO - Running pre-action listener: _resource_record_pre_action 12:05:37 INFO - Running main action method: populate_webroot 12:05:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:05:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:05:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:05:37 INFO - '--tppagecycles', 12:05:37 INFO - '7'], 12:05:37 INFO - 'tests': ['tsvgm']}}, 12:05:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:05:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:05:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:05:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:05:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['damp', 'tps']}, 12:05:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'tests': ['damp', 'tps']}, 12:05:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['dromaeo_dom']}, 12:05:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['basic_compositor_video']}, 12:05:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:05:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['a11yr', 12:05:37 INFO - 'ts_paint', 12:05:37 INFO - 'tpaint', 12:05:37 INFO - 'sessionrestore', 12:05:37 INFO - 'sessionrestore_no_auto_restore', 12:05:37 INFO - 'tabpaint']}, 12:05:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['tsvgx', 12:05:37 INFO - 'tsvgr_opacity', 12:05:37 INFO - 'tart', 12:05:37 INFO - 'tscrollx', 12:05:37 INFO - 'cart']}, 12:05:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:05:37 INFO - 'tsvgr_opacity', 12:05:37 INFO - 'tart', 12:05:37 INFO - 'tscrollx', 12:05:37 INFO - 'cart']}, 12:05:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'talos_options': ['--disable-e10s'], 12:05:37 INFO - 'tests': ['tp5o']}, 12:05:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'tests': ['tp5o']}, 12:05:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'talos_options': ['--disable-e10s', 12:05:37 INFO - '--xperf_path', 12:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:37 INFO - 'tests': ['tp5n']}, 12:05:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:37 INFO - 'talos_options': ['--xperf_path', 12:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:37 INFO - 'tests': ['tp5n']}}, 12:05:37 INFO - 'talos.zip': {'path': '', 12:05:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:05:37 INFO - Running post-action listener: _resource_record_post_action 12:05:37 INFO - ##### 12:05:37 INFO - ##### Finished populate-webroot step (success) 12:05:37 INFO - ##### 12:05:37 INFO - ##### 12:05:37 INFO - ##### Running create-virtualenv step. 12:05:37 INFO - ##### 12:05:37 INFO - Running pre-action listener: _resource_record_pre_action 12:05:37 INFO - Running main action method: create_virtualenv 12:05:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:05: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 12:05:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:05:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:38 INFO - Using real prefix '/usr' 12:05:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:05:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:05:40 INFO - Installing pip.................done. 12:05:40 INFO - Return code: 0 12:05:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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')]} 12:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05: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 12:05: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 12:05:40 INFO - Using env: {'DISPLAY': ':0', 12:05:40 INFO - 'HOME': '/home/cltbld', 12:05:40 INFO - 'LANG': 'en_US.UTF-8', 12:05:40 INFO - 'LANGUAGE': 'en_US:en', 12:05:40 INFO - 'LOGNAME': 'cltbld', 12:05:40 INFO - 'MAIL': '/var/mail/cltbld', 12:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:40 INFO - 'MOZ_NO_REMOTE': '1', 12:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:40 INFO - 'NO_EM_RESTART': '1', 12:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:40 INFO - 'PWD': '/builds/slave/test', 12:05:40 INFO - 'SHELL': '/bin/bash', 12:05:40 INFO - 'SHLVL': '1', 12:05:40 INFO - 'TERM': 'linux', 12:05:40 INFO - 'TMOUT': '86400', 12:05:40 INFO - 'USER': 'cltbld', 12:05:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:40 INFO - '_': '/tools/buildbot/bin/python'} 12:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05: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 12:05:40 INFO - Cleaning up... 12:05:40 INFO - Return code: 0 12:05:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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')]} 12:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05: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 12:05: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 12:05:40 INFO - Using env: {'DISPLAY': ':0', 12:05:40 INFO - 'HOME': '/home/cltbld', 12:05:40 INFO - 'LANG': 'en_US.UTF-8', 12:05:40 INFO - 'LANGUAGE': 'en_US:en', 12:05:40 INFO - 'LOGNAME': 'cltbld', 12:05:40 INFO - 'MAIL': '/var/mail/cltbld', 12:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:40 INFO - 'MOZ_NO_REMOTE': '1', 12:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:40 INFO - 'NO_EM_RESTART': '1', 12:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:40 INFO - 'PWD': '/builds/slave/test', 12:05:40 INFO - 'SHELL': '/bin/bash', 12:05:40 INFO - 'SHLVL': '1', 12:05:40 INFO - 'TERM': 'linux', 12:05:40 INFO - 'TMOUT': '86400', 12:05:40 INFO - 'USER': 'cltbld', 12:05:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:40 INFO - '_': '/tools/buildbot/bin/python'} 12:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:41 INFO - Downloading/unpacking psutil>=3.1.1 12:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:43 INFO - Installing collected packages: psutil 12:05:43 INFO - Running setup.py install for psutil 12:05:43 INFO - building 'psutil._psutil_linux' extension 12:05:43 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 12:05: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:05:43 INFO - building 'psutil._psutil_posix' extension 12:05:43 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 12:05: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 12:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:43 INFO - Successfully installed psutil 12:05:43 INFO - Cleaning up... 12:05:43 INFO - Return code: 0 12:05:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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')]} 12:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05: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 12:05: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 12:05:43 INFO - Using env: {'DISPLAY': ':0', 12:05:43 INFO - 'HOME': '/home/cltbld', 12:05:43 INFO - 'LANG': 'en_US.UTF-8', 12:05:43 INFO - 'LANGUAGE': 'en_US:en', 12:05:43 INFO - 'LOGNAME': 'cltbld', 12:05:43 INFO - 'MAIL': '/var/mail/cltbld', 12:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:43 INFO - 'MOZ_NO_REMOTE': '1', 12:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:43 INFO - 'NO_EM_RESTART': '1', 12:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:43 INFO - 'PWD': '/builds/slave/test', 12:05:43 INFO - 'SHELL': '/bin/bash', 12:05:43 INFO - 'SHLVL': '1', 12:05:43 INFO - 'TERM': 'linux', 12:05:43 INFO - 'TMOUT': '86400', 12:05:43 INFO - 'USER': 'cltbld', 12:05:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:43 INFO - '_': '/tools/buildbot/bin/python'} 12:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:05:45 INFO - Installing collected packages: mozsystemmonitor 12:05:45 INFO - Running setup.py install for mozsystemmonitor 12:05:45 INFO - Successfully installed mozsystemmonitor 12:05:45 INFO - Cleaning up... 12:05:46 INFO - Return code: 0 12:05:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:46 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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05:46 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 12:05:46 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 12:05:46 INFO - Using env: {'DISPLAY': ':0', 12:05:46 INFO - 'HOME': '/home/cltbld', 12:05:46 INFO - 'LANG': 'en_US.UTF-8', 12:05:46 INFO - 'LANGUAGE': 'en_US:en', 12:05:46 INFO - 'LOGNAME': 'cltbld', 12:05:46 INFO - 'MAIL': '/var/mail/cltbld', 12:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:46 INFO - 'MOZ_NO_REMOTE': '1', 12:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:46 INFO - 'NO_EM_RESTART': '1', 12:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:46 INFO - 'PWD': '/builds/slave/test', 12:05:46 INFO - 'SHELL': '/bin/bash', 12:05:46 INFO - 'SHLVL': '1', 12:05:46 INFO - 'TERM': 'linux', 12:05:46 INFO - 'TMOUT': '86400', 12:05:46 INFO - 'USER': 'cltbld', 12:05:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:46 INFO - '_': '/tools/buildbot/bin/python'} 12:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:46 INFO - Downloading/unpacking jsonschema==2.5.1 12:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:05:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:05:48 INFO - warning: no files found matching '*.txt' 12:05:48 INFO - no previously-included directories found matching 'build' 12:05:48 INFO - no previously-included directories found matching 'dist' 12:05:48 INFO - no previously-included directories found matching '.git*' 12:05:48 INFO - Installing collected packages: jsonschema, functools32 12:05:48 INFO - Running setup.py install for functools32 12:05:48 INFO - warning: no files found matching '*.txt' 12:05:48 INFO - no previously-included directories found matching 'build' 12:05:48 INFO - no previously-included directories found matching 'dist' 12:05:48 INFO - no previously-included directories found matching '.git*' 12:05:48 INFO - Successfully installed jsonschema functools32 12:05:48 INFO - Cleaning up... 12:05:48 INFO - Return code: 0 12:05:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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')]} 12:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05: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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05: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 12:05: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 12:05:48 INFO - Using env: {'DISPLAY': ':0', 12:05:48 INFO - 'HOME': '/home/cltbld', 12:05:48 INFO - 'LANG': 'en_US.UTF-8', 12:05:48 INFO - 'LANGUAGE': 'en_US:en', 12:05:48 INFO - 'LOGNAME': 'cltbld', 12:05:48 INFO - 'MAIL': '/var/mail/cltbld', 12:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:48 INFO - 'MOZ_NO_REMOTE': '1', 12:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:48 INFO - 'NO_EM_RESTART': '1', 12:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:48 INFO - 'PWD': '/builds/slave/test', 12:05:48 INFO - 'SHELL': '/bin/bash', 12:05:48 INFO - 'SHLVL': '1', 12:05:48 INFO - 'TERM': 'linux', 12:05:48 INFO - 'TMOUT': '86400', 12:05:48 INFO - 'USER': 'cltbld', 12:05:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:48 INFO - '_': '/tools/buildbot/bin/python'} 12:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:05:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:05:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:51 INFO - Downloading docopt-0.6.1.tar.gz 12:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:05:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:05:51 INFO - Running setup.py install for blobuploader 12:05:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:05:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:05:51 INFO - Running setup.py install for requests 12:05:52 INFO - Running setup.py install for docopt 12:05:52 INFO - Successfully installed blobuploader requests docopt 12:05:52 INFO - Cleaning up... 12:05:52 INFO - Return code: 0 12:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:52 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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05:52 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 12:05:52 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 12:05:52 INFO - Using env: {'DISPLAY': ':0', 12:05:52 INFO - 'HOME': '/home/cltbld', 12:05:52 INFO - 'LANG': 'en_US.UTF-8', 12:05:52 INFO - 'LANGUAGE': 'en_US:en', 12:05:52 INFO - 'LOGNAME': 'cltbld', 12:05:52 INFO - 'MAIL': '/var/mail/cltbld', 12:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:52 INFO - 'MOZ_NO_REMOTE': '1', 12:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:52 INFO - 'NO_EM_RESTART': '1', 12:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:52 INFO - 'PWD': '/builds/slave/test', 12:05:52 INFO - 'SHELL': '/bin/bash', 12:05:52 INFO - 'SHLVL': '1', 12:05:52 INFO - 'TERM': 'linux', 12:05:52 INFO - 'TMOUT': '86400', 12:05:52 INFO - 'USER': 'cltbld', 12:05:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:52 INFO - '_': '/tools/buildbot/bin/python'} 12:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:05:52 INFO - Running setup.py (path:/tmp/pip-V9e5HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:05:52 INFO - Running setup.py (path:/tmp/pip-ecAI8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:05:52 INFO - Running setup.py (path:/tmp/pip-Q9fhxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:05:52 INFO - Running setup.py (path:/tmp/pip-R9YGZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:05:52 INFO - Running setup.py (path:/tmp/pip-ObMO1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:05:52 INFO - Running setup.py (path:/tmp/pip-nU7pxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:05:52 INFO - Running setup.py (path:/tmp/pip-4khXyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:05:52 INFO - Running setup.py (path:/tmp/pip-j0QHtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:05:53 INFO - Running setup.py (path:/tmp/pip-M4cKGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:05:53 INFO - Running setup.py (path:/tmp/pip-sYlP8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:05:53 INFO - Running setup.py (path:/tmp/pip-K5MG4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:05:53 INFO - Running setup.py (path:/tmp/pip-HDih0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:05:53 INFO - Running setup.py (path:/tmp/pip-rsFJ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:05:53 INFO - Running setup.py (path:/tmp/pip-U4tZlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:05:53 INFO - Running setup.py (path:/tmp/pip-bFd2EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:05:53 INFO - Running setup.py (path:/tmp/pip-Oo2w3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:05:53 INFO - Running setup.py (path:/tmp/pip-pHsYwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:05:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:05:53 INFO - Running setup.py install for manifestparser 12:05:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:05:53 INFO - Running setup.py install for mozcrash 12:05:53 INFO - Running setup.py install for mozdebug 12:05:53 INFO - Running setup.py install for mozdevice 12:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for mozfile 12:05:54 INFO - Running setup.py install for mozhttpd 12:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for mozinfo 12:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for mozInstall 12:05:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for mozleak 12:05:54 INFO - Running setup.py install for mozlog 12:05:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for moznetwork 12:05:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:05:54 INFO - Running setup.py install for mozprocess 12:05:54 INFO - Running setup.py install for mozprofile 12:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:05:55 INFO - Running setup.py install for mozrunner 12:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:05:55 INFO - Running setup.py install for mozscreenshot 12:05:55 INFO - Running setup.py install for moztest 12:05:55 INFO - Running setup.py install for mozversion 12:05:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:05:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:05:55 INFO - Cleaning up... 12:05:55 INFO - Return code: 0 12:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:55 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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05:55 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 12:05:55 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 12:05:55 INFO - Using env: {'DISPLAY': ':0', 12:05:55 INFO - 'HOME': '/home/cltbld', 12:05:55 INFO - 'LANG': 'en_US.UTF-8', 12:05:55 INFO - 'LANGUAGE': 'en_US:en', 12:05:55 INFO - 'LOGNAME': 'cltbld', 12:05:55 INFO - 'MAIL': '/var/mail/cltbld', 12:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:55 INFO - 'MOZ_NO_REMOTE': '1', 12:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:55 INFO - 'NO_EM_RESTART': '1', 12:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:55 INFO - 'PWD': '/builds/slave/test', 12:05:55 INFO - 'SHELL': '/bin/bash', 12:05:55 INFO - 'SHLVL': '1', 12:05:55 INFO - 'TERM': 'linux', 12:05:55 INFO - 'TMOUT': '86400', 12:05:55 INFO - 'USER': 'cltbld', 12:05:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:55 INFO - '_': '/tools/buildbot/bin/python'} 12:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:05:55 INFO - Running setup.py (path:/tmp/pip-45CYzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:05: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)) 12:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:05:55 INFO - Running setup.py (path:/tmp/pip-ZXdXAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:05: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)) 12:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:05:55 INFO - Running setup.py (path:/tmp/pip-p0ZEyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:05: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)) 12:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:05:55 INFO - Running setup.py (path:/tmp/pip-uHzaA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:05:56 INFO - Running setup.py (path:/tmp/pip-iVzeSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:05:56 INFO - Running setup.py (path:/tmp/pip-vymOsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:05:56 INFO - Running setup.py (path:/tmp/pip-92lc3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:05:56 INFO - Running setup.py (path:/tmp/pip-1uq2yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:05:56 INFO - Running setup.py (path:/tmp/pip-t1rQJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:05:56 INFO - Running setup.py (path:/tmp/pip-NWrQJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:05:56 INFO - Running setup.py (path:/tmp/pip-vihCtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:05:56 INFO - Running setup.py (path:/tmp/pip-eg7xsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:05:56 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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:05:56 INFO - Running setup.py (path:/tmp/pip-asEtlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:05: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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:05:56 INFO - Running setup.py (path:/tmp/pip-Curn1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:05: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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:05:56 INFO - Running setup.py (path:/tmp/pip-HmAzVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:05: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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:05:56 INFO - Running setup.py (path:/tmp/pip-Yl2mgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:05: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)) 12:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:05:56 INFO - Running setup.py (path:/tmp/pip-wt6e4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:05: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)) 12:05: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)) 12:05: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)) 12:05: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)) 12:05: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)) 12:05: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)) 12:05:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05:58 INFO - Downloading blessings-1.6.tar.gz 12:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:05:58 INFO - Installing collected packages: blessings 12:05:58 INFO - Running setup.py install for blessings 12:05:59 INFO - Successfully installed blessings 12:05:59 INFO - Cleaning up... 12:05:59 INFO - Return code: 0 12:05:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:05:59 INFO - Reading from file tmpfile_stdout 12:05:59 INFO - Current package versions: 12:05:59 INFO - argparse == 1.2.1 12:05:59 INFO - blessings == 1.6 12:05:59 INFO - blobuploader == 1.2.4 12:05:59 INFO - docopt == 0.6.1 12:05:59 INFO - functools32 == 3.2.3-2 12:05:59 INFO - jsonschema == 2.5.1 12:05:59 INFO - manifestparser == 1.1 12:05:59 INFO - mozInstall == 1.12 12:05:59 INFO - mozcrash == 0.17 12:05:59 INFO - mozdebug == 0.1 12:05:59 INFO - mozdevice == 0.48 12:05:59 INFO - mozfile == 1.2 12:05:59 INFO - mozhttpd == 0.7 12:05:59 INFO - mozinfo == 0.9 12:05:59 INFO - mozleak == 0.1 12:05:59 INFO - mozlog == 3.2 12:05:59 INFO - moznetwork == 0.27 12:05:59 INFO - mozprocess == 0.23 12:05:59 INFO - mozprofile == 0.28 12:05:59 INFO - mozrunner == 6.12 12:05:59 INFO - mozscreenshot == 0.1 12:05:59 INFO - mozsystemmonitor == 0.3 12:05:59 INFO - moztest == 0.7 12:05:59 INFO - mozversion == 1.4 12:05:59 INFO - psutil == 3.1.1 12:05:59 INFO - requests == 1.2.3 12:05:59 INFO - wsgiref == 0.1.2 12:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:05:59 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')]} 12:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:59 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')]} 12:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:59 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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05:59 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 12:05:59 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 12:05:59 INFO - Using env: {'DISPLAY': ':0', 12:05:59 INFO - 'HOME': '/home/cltbld', 12:05:59 INFO - 'LANG': 'en_US.UTF-8', 12:05:59 INFO - 'LANGUAGE': 'en_US:en', 12:05:59 INFO - 'LOGNAME': 'cltbld', 12:05:59 INFO - 'MAIL': '/var/mail/cltbld', 12:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:59 INFO - 'MOZ_NO_REMOTE': '1', 12:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:59 INFO - 'NO_EM_RESTART': '1', 12:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:59 INFO - 'PWD': '/builds/slave/test', 12:05:59 INFO - 'SHELL': '/bin/bash', 12:05:59 INFO - 'SHLVL': '1', 12:05:59 INFO - 'TERM': 'linux', 12:05:59 INFO - 'TMOUT': '86400', 12:05:59 INFO - 'USER': 'cltbld', 12:05:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:59 INFO - '_': '/tools/buildbot/bin/python'} 12:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 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)) 12:05:59 INFO - Cleaning up... 12:05:59 INFO - Return code: 0 12:05:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:05:59 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')]} 12:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:59 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')]} 12:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:59 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 0xd32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, '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': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', '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 12:05:59 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 12:05:59 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 12:05:59 INFO - Using env: {'DISPLAY': ':0', 12:05:59 INFO - 'HOME': '/home/cltbld', 12:05:59 INFO - 'LANG': 'en_US.UTF-8', 12:05:59 INFO - 'LANGUAGE': 'en_US:en', 12:05:59 INFO - 'LOGNAME': 'cltbld', 12:05:59 INFO - 'MAIL': '/var/mail/cltbld', 12:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:59 INFO - 'MOZ_NO_REMOTE': '1', 12:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:59 INFO - 'NO_EM_RESTART': '1', 12:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:59 INFO - 'PWD': '/builds/slave/test', 12:05:59 INFO - 'SHELL': '/bin/bash', 12:05:59 INFO - 'SHLVL': '1', 12:05:59 INFO - 'TERM': 'linux', 12:05:59 INFO - 'TMOUT': '86400', 12:05:59 INFO - 'USER': 'cltbld', 12:05:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:59 INFO - '_': '/tools/buildbot/bin/python'} 12:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:05:59 INFO - Cleaning up... 12:05:59 INFO - Return code: 0 12:05:59 INFO - Running post-action listener: _resource_record_post_action 12:05:59 INFO - Running post-action listener: _start_resource_monitoring 12:05:59 INFO - Starting resource monitoring. 12:05:59 INFO - ##### 12:05:59 INFO - ##### Finished create-virtualenv step (success) 12:05:59 INFO - ##### 12:05:59 INFO - ##### 12:05:59 INFO - ##### Running install step. 12:05:59 INFO - ##### 12:05:59 INFO - Running pre-action listener: _resource_record_pre_action 12:05:59 INFO - Running main action method: install 12:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:00 INFO - Reading from file tmpfile_stdout 12:06:00 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:00 INFO - Reading from file tmpfile_stdout 12:06:00 INFO - Output received: 12:06:00 INFO - Usage: mozinstall [options] installer 12:06:00 INFO - Options: 12:06:00 INFO - -h, --help show this help message and exit 12:06:00 INFO - -d DEST, --destination=DEST 12:06:00 INFO - Directory to install application into. [default: 12:06:00 INFO - "/builds/slave/test"] 12:06:00 INFO - --app=APP Application being installed. [default: firefox] 12:06:00 INFO - mkdir: /builds/slave/test/build/application 12:06:00 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'] 12:06:00 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 12:06:17 INFO - Reading from file tmpfile_stdout 12:06:17 INFO - Output received: 12:06:17 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:17 INFO - Running post-action listener: _resource_record_post_action 12:06:17 INFO - ##### 12:06:17 INFO - ##### Finished install step (success) 12:06:17 INFO - ##### 12:06:17 INFO - ##### 12:06:17 INFO - ##### Running run-tests step. 12:06:17 INFO - ##### 12:06:17 INFO - Running pre-action listener: _resource_record_pre_action 12:06:17 INFO - Running main action method: run_tests 12:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:17 INFO - Python 2.7.3 12:06:17 INFO - Return code: 0 12:06:17 INFO - grabbing minidump binary from tooltool 12:06:17 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')]} 12:06:17 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 0xff13b0>, '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 0xff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:17 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 12:06:17 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 12:06:17 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 12:06:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:17 INFO - Return code: 0 12:06:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:06:17 INFO - Using env: {'DISPLAY': ':0', 12:06:17 INFO - 'HOME': '/home/cltbld', 12:06:17 INFO - 'LANG': 'en_US.UTF-8', 12:06:17 INFO - 'LANGUAGE': 'en_US:en', 12:06:17 INFO - 'LOGNAME': 'cltbld', 12:06:17 INFO - 'MAIL': '/var/mail/cltbld', 12:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:17 INFO - 'MOZ_NO_REMOTE': '1', 12:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:17 INFO - 'NO_EM_RESTART': '1', 12:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:17 INFO - 'PWD': '/builds/slave/test', 12:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:17 INFO - 'SHELL': '/bin/bash', 12:06:17 INFO - 'SHLVL': '1', 12:06:17 INFO - 'TERM': 'linux', 12:06:17 INFO - 'TMOUT': '86400', 12:06:17 INFO - 'USER': 'cltbld', 12:06:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468436724.943268-890611768', 12:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:17 INFO - '_': '/tools/buildbot/bin/python'} 12:06:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:06:17 INFO - mozversion application_buildid: 20160713103517 12:06:17 INFO - mozversion application_changeset: 412755b088952351ae0bb40384ec409367077f38 12:06:17 INFO - mozversion application_display_name: Nightly 12:06:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:17 INFO - mozversion application_name: Firefox 12:06:17 INFO - mozversion application_remotingname: firefox 12:06:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:06:17 INFO - mozversion application_vendor: Mozilla 12:06:17 INFO - mozversion application_version: 50.0a1 12:06:17 INFO - mozversion platform_buildid: 20160713103517 12:06:17 INFO - mozversion platform_changeset: 412755b088952351ae0bb40384ec409367077f38 12:06:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:06:17 INFO - mozversion platform_version: 50.0a1 12:06:17 INFO - using testdate: 1468436777 12:06:17 INFO - actual date: 1468436777 12:06:17 INFO - starting webserver on 'localhost:33879' 12:06:17 INFO - SUITE-START | Running 2 tests 12:06:17 INFO - TEST-START | dromaeo_css 12:06:17 INFO - operating with platform_type : linux_ 12:06:17 INFO - Initialising browser for dromaeo_css test... 12:06:17 INFO - TEST-INFO | started process 23671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfK9WJ/profile http://localhost:33879/getInfo.html) 12:06:21 INFO - PROCESS | 23671 | __metrics Screen width/height:1600/1200 12:06:21 INFO - PROCESS | 23671 | colorDepth:24 12:06:21 INFO - PROCESS | 23671 | Browser inner width/height: 1024/697 12:06:21 INFO - PROCESS | 23671 | __metrics 12:06:22 INFO - PROCESS | 23671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:06:22 INFO - PROCESS | 23671 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:23 INFO - PROCESS | 23671 | console.error: PushService: 12:06:23 INFO - PROCESS | 23671 | stateChangeProcessEnqueue: Error transitioning state 12:06:23 INFO - PROCESS | 23671 | UnknownError 12:06:23 INFO - TEST-INFO | 23671: exit 0 12:06:23 INFO - Browser initialized. 12:06:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:06:23 INFO - TEST-INFO | started process 23753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSfK9WJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:35 INFO - PROCESS | 23753 | RSS: Main: 157450240 12:06:35 INFO - PROCESS | 23753 | 12:07:26 INFO - PROCESS | 23753 | 1468436846894 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] 12:09:34 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33879/tests/dromaeo/cssquery-ext.html) 12:09:35 INFO - PROCESS | 23753 | RSS: Main: 253206528 12:09:35 INFO - PROCESS | 23753 | 12:12:38 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-ext.html (next: http://localhost:33879/tests/dromaeo/cssquery-jquery.html) 12:12:38 INFO - PROCESS | 23753 | RSS: Main: 241991680 12:12:38 INFO - PROCESS | 23753 | 12:15:40 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33879/tests/dromaeo/cssquery-mootools.html) 12:15:41 INFO - PROCESS | 23753 | RSS: Main: 242315264 12:15:41 INFO - PROCESS | 23753 | 12:18:43 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33879/tests/dromaeo/cssquery-prototype.html) 12:18:43 INFO - PROCESS | 23753 | RSS: Main: 237826048 12:18:43 INFO - PROCESS | 23753 | 12:21:46 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33879/tests/dromaeo/cssquery-yui.html) 12:21:47 INFO - PROCESS | 23753 | RSS: Main: 228577280 12:21:47 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:33879/tests/dromaeo/cssquery-yui.html (next: http://localhost:33879/tests/dromaeo/cssquery-dojo.html) 12:24:50 INFO - PROCESS | 23753 | RSS: Main: 290619392 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | __start_tp_report 12:24:50 INFO - PROCESS | 23753 | _x_x_mozilla_page_load 12:24:50 INFO - PROCESS | 23753 | _x_x_mozilla_page_load_details 12:24:50 INFO - PROCESS | 23753 | |i|pagename|runs| 12:24:50 INFO - PROCESS | 23753 | |0;dojo.html;2998.6701462839083;3005.98497007515;3022.9848850755748;3047.360054388578;3067.8159310441374;5222.660527065738;5274.4198138204865;5276.577873770098;5353.411124776277;5393.029254734146;5259.447757985405;5267.947320526793;5271;5337.519623233918;5349.170878513836;4795;4855.975720121394;4880.048390563841;4894.681845680037;5069.087564238435;4970.130227210242;4994.900101997958;4995.900081998358;5049.64652474327;5064.442911279756;4787.9521204788025;4793.137235297645;4875.341828853095;4921.950780492203;4923.384576927884;4782.473927867932;4794.736289504111;4799.064182484417;4864.318995340655;4906.828261010884;4818.325434439182;4826.951730482685;4834.54071863176;4845.878853028667;4860.246661767432;5139.897202055975;5323.095073837457;5390.757415916293;5445;5456.317960254968;5760.164776107483;5780.624259423124;5788.334341550733;5810.3899090595305;5811.331696854873;5499.202615620713;5603.355614104389;5842.766289348463;5856.736446859902;5857.85355366115;5349.839504814861;5363.678179309254;5412.702301373423;5432.103702889019;5438.45615438453;5889.352171261158;5890.528757699374;5890.793822216202;5891.263592050994;5919.733611987471;5364.409914909357;5504.559635229172;5684.403137670485;5687.971560142173;5690.231818704505;5726.169705392695;5765.1928729977835;5796.536277097822;5802.738876750472;5803.7388317524965;5588.91616625751;5599.804006859822;5611.270534830527;5621.747021384048;5700.771969121189;5478.671279723229;5572.888542229132;5615.606907516516;5704.971475142598;5718.599698021098;4303.376010478463;4314.654827613784;4317.352397140391;4349.499807522112;4354.978225108917;3812.3709587917683;3822.7515211511163;3839.328117579468;3865.6520913117956;3884.1260716338597;5228.607854410934;5235.424103348629;5330.706811125426;5368;5374.086405311106;5670.5463562914865;5689.9146512802345;5696;5697.373288938214;5714.257146570919;5325.254464374991;5415.48552887475;5418.1330987042675;5424.213489044146;5429.619926605179;4812.278158276286;4833.347498087784;4843.128236917319;4888.120138375127;4921.581665558396;5799.623024503394;5801.361850196475;5803.187553742479;5804.854878627983;5827.7668893244645;5629.26819513477;5666.15007748841;5687.289088863892;5687.5734319927;5692.203091567267;5807.274090738658;5845.41545845412;5880.206172166874;5906.468417842415;5931.792387266425;5640;5640.971795140998;5644.887102258014;5648.124540696199;5651.717414129359;5496;5683.715814209356;5756.481916627524;5759.222504961776;5764.654120752768;5436.456354364532;5480.588955828249;5486.259354987025;5495.258140151029;5514.80698175562;5456.181572764117;5466.72666366688;5477.643953143033;5487.341519017744;5489.149181876815;5363.624546281723;5376.919346209888;5420.2140689599;5436.700981446058;5476.72616369172;5605.943940560543;5660.405657406078;5667.263255776723;5703.914441283467;5716.114002329646;5483.75323110453;5489.698066606375;5498.037843377473;5510.476504732044;5524.281843360337 12:24:50 INFO - PROCESS | 23753 | |1;ext.html;584.5849446892706;616.4790751814717;627.5450298533563;629.6945981199118;633.9049142628602;33484.330313393715;36834.263314733726;36856.44715329269;36974.8151259244;43640.563594364125;41887.79056104723;46634.30048549274;46789.766051169696;46976.76511617446;47044.764776176155;8885.111488851127;9070.77323066922;9074.455532668027;9076.546172691373;9083.909160908406;8986.14631609996;9066.863997040049;9069.229115525188;9072.31957603179;9105.63577456901;9072.63709451621;9134.77163070922;9138.817223655524;9138.862917056249;9142.451452912814;9035.232005279526;9076.319276054257;9081.54592270384;9090.954545227298;9092.181703646704;8948.73153805387;9034.503102329369;9036.50299233542;9036.728898133066;9038.141376569216;43024.3546346805;43294;43404;43460.696179114675;43475.34786978198;3440.6753399940953;3487.7384196185135;3528.311979164064;3577.141486043357;3612.9096772580633;33165.834170829236;33232.501512477334;33551.16122096943;33729.32541349159;34357.312853742784;4413.624841888443;4482.8879278017985;4483.417155769729;4505.301678239878;4604.424446944132;378860.4227915454;379771;379773;381701;385732;59699.701501492214;60401.39598604046;60419;60502.46231532653;60521;35916.281674366364;36885.26229475396;36969.81515092461;38414.80792596075;38439;16559.503214903572;16638.75041874373;16707.331706731595;16722.414715484898;16756;12622.87377126217;12721.427535760913;12722.173058751152;12728.109032367645;12733.236005839679;19882;19947.102380392917;20000.699989500168;20059.197632094845;20135;7148.142222933281;7170.435190873678;7269.781906542812;7307.525010874276;7483.251674832473;985.5269470654126;1090.929089609173;1102.7629059752032;1106.634810512529;1133.4955944604571;33786.49320260198;33882.66117338795;33890;34700.82649586736;34750.652493475245;936.2930987104693;1059.9523021464054;1106.5020740666732;1128.2215271462665;1185.9407029648482;16324.75512867308;16580.17099145038;16691.49925502237;16880.915595421946;17069.31722731077;558078;562513;564956;565117;566223;53794;54929.72535137299;54997;55077;55128.17307740387;1108.7948729485072;1317.5981325695564;1346.8585798491213;1385.6605131742585;1397.8881689465022;32061;34017.82991085128;34150.82924585361;34183;34885.476717848745;49453;50147.49852501574;50174.2473862885;50223.49776502188;50399.74800125976;419605;423623;424292;426003;761704;27787.861060694566;28187.71812281851;28307.584620769292;29200.853995729885;29236.707632923397;47593;48371.75814121048;49004;49165;49634.75182624064;39610.40584391179;40950.38574421446;41081.79459102685;41767.16465670609;42283.577164227965;40563.59436405598;41420.79289603653;41580;41717;41896.371554427315;40588.594114058484;41348;41506.1698766029;41716.58283417127;41870.790646046575;34220.82889585536;36375.63624363722;36613.26773464569;37495.62504374921;37499;28075.859620701765;28270.455658990788;28430.627748900606;28463;28960.42079158447 12:24:50 INFO - PROCESS | 23753 | |2;jquery.html;373.16225074707285;382.14018458468445;389.51505375807113;393.87592908233904;410.09573889573494;17900;19888.105035273413;19892.50268743282;19999.700004499926;20056.398308050782;18916.81083189168;19324;19618.41144765656;19806.504837379074;19906.800931990674;5432.076546987022;5739.713014349297;5924.674142922137;5936.109583562457;5945.197398351211;5813.128030795372;5814.680192589406;5825.7378417971295;5865.296164460271;5877.324107727602;5666.5183459406;5674.716264186774;5792.275965504312;5793.826185214451;5855.736491857877;5733.741981610796;5811.4479124483105;5822.155787410844;5828.2131912191735;5850.88298234035;5035.0685123252315;5155.149400348938;5192.636515443921;5192.792288308463;5206.401263854667;23601.763982360128;23645.76354236453;23704.525909481887;24444.633330500055;24481.143159989315;2213.734351877785;2361.1381845626393;2443.9389015274583;2514.0823599386276;2633.473305338921;14525.765309948667;14949.103053816805;15089.54731358061;15322;15506;1826.0960824391877;1865.0861078071782;1888.4901076709211;1943.630710165064;1952.6290004899024;76916.61541692312;79274;81257;81727;81959.59020204861;10498.002689744462;10659.360438373722;10721.142308615292;10975.50610222542;10992.340459572451;14840.18378989166;14948.476803312049;14973.70052598942;14987.100773953598;15012;8008.799780005546;8104.27061564462;8228.711995080144;8310.958445207736;8357.206065423776;7898.249666281694;7961.482503637245;7967.601619918981;8084.676612935416;8199.42604017725;6581.473482121419;6623.4701223901975;6642.7342906284175;6746.265674177009;6842.93157068423;1878.3238034307637;1892.1485331600834;1950.8927009014355;1990.1442379776836;1991.1924186896406;932.6455946740195;951.9524023798782;997.4314640654757;1022.5756311130946;1023.5240613114937;20163.193472260944;20427.182912683325;20549.89725051395;20563.588728225353;20634;997.4613708597421;1004.5830980143159;1005.9647912323034;1044.738815296176;1104.5526561742506;11074.723131921604;11768.176227663982;11818.586349477728;11828.645140645795;11839.171258011856;466751;469089;481161;482783;490059;83626;84278;84522.5773871139;85484.57257713671;85602.4397560239;1037.1339931157568;1052.8052310322614;1079.6707004363745;1109.1958330210693;1109.517359948425;17762.733558996882;18021;18326.26694932241;18476.136198889195;18693.15880785395;38575;39425;40142.39786403148;40263.79868100641;40616;52073.689088651685;52548.211776822616;53562;53771.19343209777;54165.18752218799;8611.268042216481;8638.093000234885;8830.410526105363;8844.955775221082;9001.954990225007;13312.534061307808;13482.325883705971;13511.797323039966;13525.18848869071;13722.519711810039;11067.778644427228;11646.534138634359;11728.41357932083;11994.280343179436;12082.758344832879;11860.466279017292;11902.821457677968;12022.458989345325;12083.39583020863;12245.69385765363;11933;12009.339486328336;12040;12189.51241950312;12471.314077725448;8502.44734092282;8627.6980305689;8687.956560217412;8849.734507964771;8962.058983806866;10882;10893.945530272298;11888.643340699793;11929.582464613697;12056.879431205927 12:24:50 INFO - PROCESS | 23753 | |3;mootools.html;1357.3349058961112;1498.2658497336301;1536.0553259745257;1658.8921720088194;1818.2817786974147;8541.615627296778;9006.864897026542;9023.458592484456;9207.769805754859;9224.584893679783;8912.420692654989;9096.63613455461;9103;9107.408018478794;9125.49809760463;2034.9389518314474;2088.728465299509;2097.769245383007;2356.1164563288767;2381.5117900830373;1965.4594986378718;2173.2936795541514;2239.5744808486334;2242.3497185816095;2258.695076164713;2371.9407014824596;2379.6192609182535;2395.9520809583796;2396.7842894139526;2396.9161079362225;1984.771751248596;2343.1330407749156;2345.683332750091;2348.0842471436154;2351.576716191085;2277.567262220173;2324.1749179041367;2326.9650955235684;2358.8348815582917;2366.0535785685865;9008.864867027;9083.863742043875;9108.817823643556;9129.863052054225;9165.679201227926;5070.264811602334;5148.279240906276;5161.148410512261;5164.173732202867;5168.198929165986;3462.480627905809;3467.1158854492196;3493.777696537349;3600.5499312585926;3618.5476815398074;1158.362900404774;1159.0727418065599;1161.1233518693416;1163.8661553921238;1171.2035815645443;12255.69360765979;12293.938530307381;12299.954503867182;12302.200356976768;12420.875791242062;4468.240399132155;4478.7760611969925;4657.022025374641;4669.696469729524;4733.219018861849;10295.94852025735;10326.070653641209;10335.483225838678;10337.896621033844;10343.01741334572;5300.204969254565;5313.415524292402;5376.032314183406;5383.300170977748;5384.461553844662;4837.274408838632;4913.950860491421;4938.185199442052;4940.530649588283;5000.6249531284575;3783.45139954705;3808.1431677872256;3854.7494412863634;3897.824597893102;3903.6486716195677;1098.2092893116942;1098.2916019167592;1117.8435019097333;1120.8094623913955;1139.7834411461795;973.634886917406;978.2076518020284;989.8465737810651;997.6408492942535;1002.1331548210745;5885.852853678607;5888;5977;6130.478909292671;6186.783462578788;448.3789950918002;457.1063570719236;458.00155660659414;458.6239283787329;461.7414248021119;3982.6216509431556;4181.519125300569;4209.915801683949;4217.4306468626955;4287.464066991626;11132;11515.884841151481;11526.538938442536;11568.76862462746;11593.6521904343;10763.19276054299;11146.164037697205;11163.106951443864;11449.141314401453;11474.655760327203;8396.580170991427;8499.532525711145;8531.616077276538;8537.274331681876;8581.570921453902;6048.637081775108;6313.842153946188;6404.327545607644;6445.097686323825;6484.967575162094;10290.845637315297;10499.370037797757;10597.993190646876;10625.468726563795;10692.679219623424;9516.095970882756;10791.838122428013;11062;11079.889201108208;11083.833742494031;7910.7231246906085;8269.00771907375;8276.958615207126;8497.362697797565;8500.149985001697;8685.91314086851;8700.086490918362;8700.956495217484;8709.433886797338;8881.600327985385;7885.053793544811;7918.406119540942;8050.194980501903;8077.959610201911;8149.79625509367;7972.84054318922;8061.4760040597175;8098.878516822135;8103.8379232413845;8205.056418511947;7472.439567032603;7478.439117066133;7500.699972001277;7543.0948286206;7545.547267163988;4586.564276393738;5194.532492075731;5213.452587478412;5323.787048518016;5444.646098003617;5406.756695948613;5477.1510415885605;5493.203485494501;5518.972405137949;5739.397363276796 12:24:50 INFO - PROCESS | 23753 | |4;prototype.html;305.98317092559915;308.8671871095429;313.78819296974535;315.17581524313914;315.2717223214375;5218.008578370107;5244.160934250521;5260.789568417268;5263.210518422234;5303.363596368436;4974.2538619207135;5025.246213068032;5203.829138443848;5207.739613019353;5210.9478905210935;4036.132231570212;4079.4288799567935;4087.4686290782156;4098.159877225176;4107.712460127792;4082.3060079786505;4087.9591204087874;4099.7745124018165;4103.076807718255;4116.094459218967;3760.02239417752;3884.9223015539674;4006.479157709494;4007.2786898358286;4070.715049946505;4011.939820902689;4031.8185681644395;4036.1120553478186;4059.1881623675235;4062.1266427718033;3563.1626567756557;3563.4476656118345;3564.4296912494137;3564.893053208382;3566.857325706969;4898.485659005824;5094.59243260542;5096.413912400084;5146.511081447256;5164.509371609691;4569.326943737918;4579.67942244043;4601.792919318638;4603.010352774136;4603.792829322655;5461.5357694596005;5473.17902314652;5488.353493951799;5496.80761173357;5500.80747173851;3669.559652841676;3863.111484358585;3863.3239183142837;3866.3040652682507;3871.9032024199337;5629.4652008059575;5630.971845140789;5651.689157096358;5663.207150998864;5689.345725241609;3924.4898163238595;3963.524377074712;3967.6032396760093;3969.166475040216;3972.602739726004;3928.9607103929166;4012.973448408535;4016.4376987221813;4019.336809426412;4022.3363145080734;4575.2450845610765;4580.679352445363;4594.33382159585;4602.861914142581;4618.284165954283;5431.2396264522995;5435.320584926884;5464.3442786865835;5469.535089517435;5541.92423205125;1258.3456602566614;1317.1504379675248;1352.891768658505;1369.1511263016994;1369.6165073779357;948.7153853843819;973.1436336024253;975.3952549419264;976.6972238606055;977.9559919803626;5228.529432351107;5240.737963101829;5264.947350526522;5294.444083371268;5300.575953923677;5573.41479144692;5575.303087114111;5598.300212473441;5599.412061733459;5626.85932851682;5074.2895994560795;5366.6243362965;5374.4739972213;5379.5427388671615;5382.381026181961;2937.6474823021376;2967.9018763057807;2974.985125074361;2987.268119310783;2992.5660779186896;5612.071549915076;5733.541316694655;5771.826845194651;5772.278465191851;5799.652020878676;5691.243779105853;5704.486596206361;5728.255326807488;5770.16332631766;5792.594518383673;5762;5787.189793428924;5836.474717275466;5847.736851841677;5875.148103525051;5528.44715528444;5668.093105103164;5677.091665333527;5678.858028549154;5689.800856969986;5554.833354999357;5577.74900129487;5592.664440133605;5616.427400327915;5631.211630371669;5620.4098569649595;5821.70891455417;5823.82528524145;5829.775747092988;5870.324912634931;3762.94355584661;3907.7264591478324;3908.2183563288027;3910.240391823748;3920.4903362562686;5430.235173568685;5631.183478395692;5634.971825141012;5646.475451628119;5651.06144804691;5478.753456094406;5493.642913210629;5518.255035570147;5521.475459831309;5527.834164975057;5254.343207099113;5491.533219676372;5521.3926468089285;5530.198121272312;5536.75084621201;5387.030334539821;5393.27190829233;5409.594280429063;5414.269073675004;5435.157550579666;5479.369872464717;5497.752601132878;5507.118860982224;5527.8894422110525;5533.142362933751;5272.7100009499845;5334.573234141337;5381.627684940472;5434.619576629598;5440.863978400572 12:24:50 INFO - PROCESS | 23753 | |5;yui.html;706.1349846438114;762.0931092000517;792.6948124971888;814.600845585663;839.9207018980611;14315.642108947282;15105.244737763109;15490.767638485431;16201.10893900835;16251.268692908818;13683.384247708853;13695.246761428118;13851.030427870053;13873.861261387383;13909.860901390983;679.6839469646613;805.6737021506285;823.7240524424295;823.8887750153713;824.6742536698001;795.2087672765606;821.9013718353806;823.7117009046816;826.9379796515256;827.5820710541199;842.1157784326464;842.5113434208145;845.8604330285496;846.0946786937978;846.5090247656344;693.4002088193727;718.6227230703922;838.6938767349934;838.7357982235576;841.6927821345196;525.2672521832061;525.5795363709018;607.2530787131808;624.7157543317779;627.8618703885138;12598.37008149598;12701.174423662525;12729.681757956032;12777.680557986032;12778.680532986657;14339.928300358535;14406.639834004234;14645.926770366186;14671.248022926648;14929.701405971928;13347.799783003262;13482.662933426645;13619.795703064461;13622.863771362358;14189.929050354682;4555.612772914306;4612.077584483083;4641.071785642885;4715.174844402216;4790.041991601659;33185.83407082949;33437.665623343695;33438.83280583606;33439.83280083584;33441.83279083613;11130.165237607212;11335.716607084723;11522.308661480338;11937.61307381844;11980.101492388107;20150.69773953392;20151.395458135987;20168.19327226924;20171.394858153984;20176.89911550433;8192.385571082194;8256.587170641444;8265.46274492156;8266.751997439966;8295.502269863828;4523.185826551252;4830.082284365959;4838.903221935541;4842.927356089662;4852.199387101089;3505.8422370993367;3585.515955345995;3590.676839084495;3601.6218297078954;3610.6028336882923;603.0712702438196;626.2453743239386;626.7680958045553;627.6516533324049;628.0391001767304;665.8535122273092;711.4877288352378;732.209214048826;746.3831598536917;782.8590853646284;9235.010337698117;9527.38034534131;9729.70810875675;9732;9903.356281841658;604.9969750151221;612.3998481488167;701.2251462134268;724.5580196080386;740.6629983357559;4263;4674.252119660838;4697.812087516461;4750.643701722384;4756.167670657621;65615;81209;117319;124335.37832310781;124479;105529.47235263775;105870;106311;107621;107782.46108769406;53167.20249196265;62796;70577.64711176412;89339.55330223308;91090;9082.818343632958;9241.537923103684;9252.213561847318;9291.62833486653;9323.114304141096;53642;53775.46224537861;53976.730116349165;54241.45758542364;54511;72137.63931180311;74626.62686686532;80057.59971200107;82196.58901705453;83330;11074.224804263624;11095.11239100886;11119.44402779874;11271.04196143337;11776.352300623548;12976;13034.413451394521;13159.802602961156;13271.933640331736;13347.532836350681;10933.945330273616;12112.091593130726;12398.504059837505;12474.438650260941;12540.310282934526;13675.79486307726;13971.441142354191;14292.785608215678;14374.137551746928;14949.327280272197;13954.79067814004;13968.58094257174;14151.43394264259;14178.220197888802;14651.487197948021;11149;11492.425378730863;11672.299662020307;11774.52901883915;12010.216781713732;10950;11752.823707644564;11802.645920622395;12015.81976270374;12272.631821045383 12:24:50 INFO - PROCESS | 23753 | __end_tp_report 12:24:50 INFO - PROCESS | 23753 | __start_cc_report 12:24:50 INFO - PROCESS | 23753 | _x_x_mozilla_cycle_collect,826 12:24:50 INFO - PROCESS | 23753 | __end_cc_report 12:24:50 INFO - PROCESS | 23753 | __startTimestamp1468437890401__endTimestamp 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | ------- Summary: start ------- 12:24:50 INFO - PROCESS | 23753 | Number of tests: 6 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#0] dojo.html Cycles:165 Average:5288.47 Median:5466.73 stddev:608.06 (11.1%) stddev-sans-first:582.79 12:24:50 INFO - PROCESS | 23753 | Values: 2998.7 3006.0 3023.0 3047.4 3067.8 5222.7 5274.4 5276.6 5353.4 5393.0 5259.4 5267.9 5271.0 5337.5 5349.2 4795.0 4856.0 4880.0 4894.7 5069.1 4970.1 4994.9 4995.9 5049.6 5064.4 4788.0 4793.1 4875.3 4922.0 4923.4 4782.5 4794.7 4799.1 4864.3 4906.8 4818.3 4827.0 4834.5 4845.9 4860.2 5139.9 5323.1 5390.8 5445.0 5456.3 5760.2 5780.6 5788.3 5810.4 5811.3 5499.2 5603.4 5842.8 5856.7 5857.9 5349.8 5363.7 5412.7 5432.1 5438.5 5889.4 5890.5 5890.8 5891.3 5919.7 5364.4 5504.6 5684.4 5688.0 5690.2 5726.2 5765.2 5796.5 5802.7 5803.7 5588.9 5599.8 5611.3 5621.7 5700.8 5478.7 5572.9 5615.6 5705.0 5718.6 4303.4 4314.7 4317.4 4349.5 4355.0 3812.4 3822.8 3839.3 3865.7 3884.1 5228.6 5235.4 5330.7 5368.0 5374.1 5670.5 5689.9 5696.0 5697.4 5714.3 5325.3 5415.5 5418.1 5424.2 5429.6 4812.3 4833.3 4843.1 4888.1 4921.6 5799.6 5801.4 5803.2 5804.9 5827.8 5629.3 5666.2 5687.3 5687.6 5692.2 5807.3 5845.4 5880.2 5906.5 5931.8 5640.0 5641.0 5644.9 5648.1 5651.7 5496.0 5683.7 5756.5 5759.2 5764.7 5436.5 5480.6 5486.3 5495.3 5514.8 5456.2 5466.7 5477.6 5487.3 5489.1 5363.6 5376.9 5420.2 5436.7 5476.7 5605.9 5660.4 5667.3 5703.9 5716.1 5483.8 5489.7 5498.0 5510.5 5524.3 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#1] ext.html Cycles:180 Average:62874.66 Median:41648.29 stddev:130672.52 (313.8%) stddev-sans-first:130955.40 12:24:50 INFO - PROCESS | 23753 | Values: 584.6 616.5 627.5 629.7 633.9 33484.3 36834.3 36856.4 36974.8 43640.6 41887.8 46634.3 46789.8 46976.8 47044.8 8885.1 9070.8 9074.5 9076.5 9083.9 8986.1 9066.9 9069.2 9072.3 9105.6 9072.6 9134.8 9138.8 9138.9 9142.5 9035.2 9076.3 9081.5 9091.0 9092.2 8948.7 9034.5 9036.5 9036.7 9038.1 43024.4 43294.0 43404.0 43460.7 43475.3 3440.7 3487.7 3528.3 3577.1 3612.9 33165.8 33232.5 33551.2 33729.3 34357.3 4413.6 4482.9 4483.4 4505.3 4604.4 378860.4 379771.0 379773.0 381701.0 385732.0 59699.7 60401.4 60419.0 60502.5 60521.0 35916.3 36885.3 36969.8 38414.8 38439.0 16559.5 16638.8 16707.3 16722.4 16756.0 12622.9 12721.4 12722.2 12728.1 12733.2 19882.0 19947.1 20000.7 20059.2 20135.0 7148.1 7170.4 7269.8 7307.5 7483.3 985.5 1090.9 1102.8 1106.6 1133.5 33786.5 33882.7 33890.0 34700.8 34750.7 936.3 1060.0 1106.5 1128.2 1185.9 16324.8 16580.2 16691.5 16880.9 17069.3 558078.0 562513.0 564956.0 565117.0 566223.0 53794.0 54929.7 54997.0 55077.0 55128.2 1108.8 1317.6 1346.9 1385.7 1397.9 32061.0 34017.8 34150.8 34183.0 34885.5 49453.0 50147.5 50174.2 50223.5 50399.7 419605.0 423623.0 424292.0 426003.0 761704.0 27787.9 28187.7 28307.6 29200.9 29236.7 47593.0 48371.8 49004.0 49165.0 49634.8 39610.4 40950.4 41081.8 41767.2 42283.6 40563.6 41420.8 41580.0 41717.0 41896.4 40588.6 41348.0 41506.2 41716.6 41870.8 34220.8 36375.6 36613.3 37495.6 37499.0 28075.9 28270.5 28430.6 28463.0 28960.4 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#2] jquery.html Cycles:180 Average:28599.54 Median:13074.23 stddev:78598.97 (601.2%) stddev-sans-first:78790.88 12:24:50 INFO - PROCESS | 23753 | Values: 373.2 382.1 389.5 393.9 410.1 17900.0 19888.1 19892.5 19999.7 20056.4 18916.8 19324.0 19618.4 19806.5 19906.8 5432.1 5739.7 5924.7 5936.1 5945.2 5813.1 5814.7 5825.7 5865.3 5877.3 5666.5 5674.7 5792.3 5793.8 5855.7 5733.7 5811.4 5822.2 5828.2 5850.9 5035.1 5155.1 5192.6 5192.8 5206.4 23601.8 23645.8 23704.5 24444.6 24481.1 2213.7 2361.1 2443.9 2514.1 2633.5 14525.8 14949.1 15089.5 15322.0 15506.0 1826.1 1865.1 1888.5 1943.6 1952.6 76916.6 79274.0 81257.0 81727.0 81959.6 10498.0 10659.4 10721.1 10975.5 10992.3 14840.2 14948.5 14973.7 14987.1 15012.0 8008.8 8104.3 8228.7 8311.0 8357.2 7898.2 7961.5 7967.6 8084.7 8199.4 6581.5 6623.5 6642.7 6746.3 6842.9 1878.3 1892.1 1950.9 1990.1 1991.2 932.6 952.0 997.4 1022.6 1023.5 20163.2 20427.2 20549.9 20563.6 20634.0 997.5 1004.6 1006.0 1044.7 1104.6 11074.7 11768.2 11818.6 11828.6 11839.2 466751.0 469089.0 481161.0 482783.0 490059.0 83626.0 84278.0 84522.6 85484.6 85602.4 1037.1 1052.8 1079.7 1109.2 1109.5 17762.7 18021.0 18326.3 18476.1 18693.2 38575.0 39425.0 40142.4 40263.8 40616.0 52073.7 52548.2 53562.0 53771.2 54165.2 8611.3 8638.1 8830.4 8845.0 9002.0 13312.5 13482.3 13511.8 13525.2 13722.5 11067.8 11646.5 11728.4 11994.3 12082.8 11860.5 11902.8 12022.5 12083.4 12245.7 11933.0 12009.3 12040.0 12189.5 12471.3 8502.4 8627.7 8688.0 8849.7 8962.1 10882.0 10893.9 11888.6 11929.6 12056.9 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#3] mootools.html Cycles:180 Average:5948.34 Median:2522.59 stddev:3459.43 (137.1%) stddev-sans-first:3451.93 12:24:50 INFO - PROCESS | 23753 | Values: 1357.3 1498.3 1536.1 1658.9 1818.3 8541.6 9006.9 9023.5 9207.8 9224.6 8912.4 9096.6 9103.0 9107.4 9125.5 2034.9 2088.7 2097.8 2356.1 2381.5 1965.5 2173.3 2239.6 2242.3 2258.7 2371.9 2379.6 2396.0 2396.8 2396.9 1984.8 2343.1 2345.7 2348.1 2351.6 2277.6 2324.2 2327.0 2358.8 2366.1 9008.9 9083.9 9108.8 9129.9 9165.7 5070.3 5148.3 5161.1 5164.2 5168.2 3462.5 3467.1 3493.8 3600.5 3618.5 1158.4 1159.1 1161.1 1163.9 1171.2 12255.7 12293.9 12300.0 12302.2 12420.9 4468.2 4478.8 4657.0 4669.7 4733.2 10295.9 10326.1 10335.5 10337.9 10343.0 5300.2 5313.4 5376.0 5383.3 5384.5 4837.3 4914.0 4938.2 4940.5 5000.6 3783.5 3808.1 3854.7 3897.8 3903.6 1098.2 1098.3 1117.8 1120.8 1139.8 973.6 978.2 989.8 997.6 1002.1 5885.9 5888.0 5977.0 6130.5 6186.8 448.4 457.1 458.0 458.6 461.7 3982.6 4181.5 4209.9 4217.4 4287.5 11132.0 11515.9 11526.5 11568.8 11593.7 10763.2 11146.2 11163.1 11449.1 11474.7 8396.6 8499.5 8531.6 8537.3 8581.6 6048.6 6313.8 6404.3 6445.1 6485.0 10290.8 10499.4 10598.0 10625.5 10692.7 9516.1 10791.8 11062.0 11079.9 11083.8 7910.7 8269.0 8277.0 8497.4 8500.1 8685.9 8700.1 8701.0 8709.4 8881.6 7885.1 7918.4 8050.2 8078.0 8149.8 7972.8 8061.5 8098.9 8103.8 8205.1 7472.4 7478.4 7500.7 7543.1 7545.5 4586.6 5194.5 5213.5 5323.8 5444.6 5406.8 5477.2 5493.2 5519.0 5739.4 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#4] prototype.html Cycles:180 Average:4600.35 Median:5297.51 stddev:1367.84 (25.8%) stddev-sans-first:1333.15 12:24:50 INFO - PROCESS | 23753 | Values: 306.0 308.9 313.8 315.2 315.3 5218.0 5244.2 5260.8 5263.2 5303.4 4974.3 5025.2 5203.8 5207.7 5210.9 4036.1 4079.4 4087.5 4098.2 4107.7 4082.3 4088.0 4099.8 4103.1 4116.1 3760.0 3884.9 4006.5 4007.3 4070.7 4011.9 4031.8 4036.1 4059.2 4062.1 3563.2 3563.4 3564.4 3564.9 3566.9 4898.5 5094.6 5096.4 5146.5 5164.5 4569.3 4579.7 4601.8 4603.0 4603.8 5461.5 5473.2 5488.4 5496.8 5500.8 3669.6 3863.1 3863.3 3866.3 3871.9 5629.5 5631.0 5651.7 5663.2 5689.3 3924.5 3963.5 3967.6 3969.2 3972.6 3929.0 4013.0 4016.4 4019.3 4022.3 4575.2 4580.7 4594.3 4602.9 4618.3 5431.2 5435.3 5464.3 5469.5 5541.9 1258.3 1317.2 1352.9 1369.2 1369.6 948.7 973.1 975.4 976.7 978.0 5228.5 5240.7 5264.9 5294.4 5300.6 5573.4 5575.3 5598.3 5599.4 5626.9 5074.3 5366.6 5374.5 5379.5 5382.4 2937.6 2967.9 2975.0 2987.3 2992.6 5612.1 5733.5 5771.8 5772.3 5799.7 5691.2 5704.5 5728.3 5770.2 5792.6 5762.0 5787.2 5836.5 5847.7 5875.1 5528.4 5668.1 5677.1 5678.9 5689.8 5554.8 5577.7 5592.7 5616.4 5631.2 5620.4 5821.7 5823.8 5829.8 5870.3 3762.9 3907.7 3908.2 3910.2 3920.5 5430.2 5631.2 5635.0 5646.5 5651.1 5478.8 5493.6 5518.3 5521.5 5527.8 5254.3 5491.5 5521.4 5530.2 5536.8 5387.0 5393.3 5409.6 5414.3 5435.2 5479.4 5497.8 5507.1 5527.9 5533.1 5272.7 5334.6 5381.6 5434.6 5440.9 12:24:50 INFO - PROCESS | 23753 | 12:24:50 INFO - PROCESS | 23753 | [#5] yui.html Cycles:180 Average:19172.62 Median:4583.85 stddev:27998.29 (610.8%) stddev-sans-first:28042.50 12:24:50 INFO - PROCESS | 23753 | Values: 706.1 762.1 792.7 814.6 839.9 14315.6 15105.2 15490.8 16201.1 16251.3 13683.4 13695.2 13851.0 13873.9 13909.9 679.7 805.7 823.7 823.9 824.7 795.2 821.9 823.7 826.9 827.6 842.1 842.5 845.9 846.1 846.5 693.4 718.6 838.7 838.7 841.7 525.3 525.6 607.3 624.7 627.9 12598.4 12701.2 12729.7 12777.7 12778.7 14339.9 14406.6 14645.9 14671.2 14929.7 13347.8 13482.7 13619.8 13622.9 14189.9 4555.6 4612.1 4641.1 4715.2 4790.0 33185.8 33437.7 33438.8 33439.8 33441.8 11130.2 11335.7 11522.3 11937.6 11980.1 20150.7 20151.4 20168.2 20171.4 20176.9 8192.4 8256.6 8265.5 8266.8 8295.5 4523.2 4830.1 4838.9 4842.9 4852.2 3505.8 3585.5 3590.7 3601.6 3610.6 603.1 626.2 626.8 627.7 628.0 665.9 711.5 732.2 746.4 782.9 9235.0 9527.4 9729.7 9732.0 9903.4 605.0 612.4 701.2 724.6 740.7 4263.0 4674.3 4697.8 4750.6 4756.2 65615.0 81209.0 117319.0 124335.4 124479.0 105529.5 105870.0 106311.0 107621.0 107782.5 53167.2 62796.0 70577.6 89339.6 91090.0 9082.8 9241.5 9252.2 9291.6 9323.1 53642.0 53775.5 53976.7 54241.5 54511.0 72137.6 74626.6 80057.6 82196.6 83330.0 11074.2 11095.1 11119.4 11271.0 11776.4 12976.0 13034.4 13159.8 13271.9 13347.5 10933.9 12112.1 12398.5 12474.4 12540.3 13675.8 13971.4 14292.8 14374.1 14949.3 13954.8 13968.6 14151.4 14178.2 14651.5 11149.0 11492.4 11672.3 11774.5 12010.2 10950.0 11752.8 11802.6 12015.8 12272.6 12:24:50 INFO - PROCESS | 23753 | -------- Summary: end -------- 12:24:50 INFO - PROCESS | 23753 | 12:24:51 INFO - TEST-INFO | 23753: exit 0 12:24:51 INFO - TEST-OK | dromaeo_css | took 1113469ms 12:24:51 INFO - TEST-START | kraken 12:24:51 INFO - operating with platform_type : linux_ 12:24:51 INFO - Initialising browser for kraken test... 12:24:51 INFO - TEST-INFO | started process 23949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP7aj4D/profile http://localhost:33879/getInfo.html) 12:24:55 INFO - PROCESS | 23949 | __metrics Screen width/height:1600/1200 12:24:55 INFO - PROCESS | 23949 | colorDepth:24 12:24:55 INFO - PROCESS | 23949 | Browser inner width/height: 1024/697 12:24:55 INFO - PROCESS | 23949 | __metrics 12:24:56 INFO - PROCESS | 23949 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:24:56 INFO - PROCESS | 23949 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:24:57 INFO - TEST-INFO | 23949: exit 0 12:24:57 INFO - Browser initialized. 12:24:57 INFO - Running cycle 1/1 for kraken test... 12:24:57 INFO - TEST-INFO | started process 24035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP7aj4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:08 INFO - PROCESS | 24035 | RSS: Main: 158044160 12:25:08 INFO - PROCESS | 24035 | 12:25:11 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33879/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:12 INFO - PROCESS | 24035 | RSS: Main: 215621632 12:25:12 INFO - PROCESS | 24035 | 12:25:14 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33879/tests/kraken/driver.html?testName=audio-dft) 12:25:15 INFO - PROCESS | 24035 | RSS: Main: 204165120 12:25:15 INFO - PROCESS | 24035 | 12:25:18 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33879/tests/kraken/driver.html?testName=audio-fft) 12:25:19 INFO - PROCESS | 24035 | RSS: Main: 269684736 12:25:19 INFO - PROCESS | 24035 | 12:25:21 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33879/tests/kraken/driver.html?testName=audio-oscillator) 12:25:21 INFO - PROCESS | 24035 | RSS: Main: 181243904 12:25:21 INFO - PROCESS | 24035 | 12:25:23 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33879/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:25:24 INFO - PROCESS | 24035 | RSS: Main: 185180160 12:25:24 INFO - PROCESS | 24035 | 12:25:27 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33879/tests/kraken/driver.html?testName=imaging-darkroom) 12:25:28 INFO - PROCESS | 24035 | RSS: Main: 219705344 12:25:28 INFO - PROCESS | 24035 | 12:25:31 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33879/tests/kraken/driver.html?testName=imaging-desaturate) 12:25:32 INFO - PROCESS | 24035 | RSS: Main: 221401088 12:25:32 INFO - PROCESS | 24035 | 12:25:34 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33879/tests/kraken/driver.html?testName=json-parse-financial) 12:25:35 INFO - PROCESS | 24035 | RSS: Main: 221691904 12:25:35 INFO - PROCESS | 24035 | 12:25:37 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33879/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:25:37 INFO - PROCESS | 24035 | RSS: Main: 206458880 12:25:37 INFO - PROCESS | 24035 | 12:25:39 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:25:40 INFO - PROCESS | 24035 | RSS: Main: 209993728 12:25:40 INFO - PROCESS | 24035 | 12:25:41 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:25:42 INFO - PROCESS | 24035 | RSS: Main: 212168704 12:25:42 INFO - PROCESS | 24035 | 12:25:45 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:25:45 INFO - PROCESS | 24035 | RSS: Main: 225083392 12:25:45 INFO - PROCESS | 24035 | 12:25:48 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:25:49 INFO - PROCESS | 24035 | RSS: Main: 226328576 12:25:49 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | Cycle 1(1): loaded http://localhost:33879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33879/tests/kraken/driver.html?testName=ai-astar) 12:25:50 INFO - PROCESS | 24035 | RSS: Main: 269471744 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | __start_tp_report 12:25:50 INFO - PROCESS | 24035 | _x_x_mozilla_page_load 12:25:50 INFO - PROCESS | 24035 | _x_x_mozilla_page_load_details 12:25:50 INFO - PROCESS | 24035 | |i|pagename|runs| 12:25:50 INFO - PROCESS | 24035 | |0;ai-astar;102;113;112;111;113;113;112;113;111;111 12:25:50 INFO - PROCESS | 24035 | |1;audio-beat-detection;143;116;120;175;124;124;146;118;157;117 12:25:50 INFO - PROCESS | 24035 | |2;audio-dft;161;161;161;160;160;162;164;164;160;161 12:25:50 INFO - PROCESS | 24035 | |3;audio-fft;75;76;76;140;75;76;74;74;105;74 12:25:50 INFO - PROCESS | 24035 | |4;audio-oscillator;83;83;113;84;83;85;122;85;83;142 12:25:50 INFO - PROCESS | 24035 | |5;imaging-gaussian-blur;118;117;117;116;117;117;118;116;117;116 12:25:50 INFO - PROCESS | 24035 | |6;imaging-darkroom;146;146;147;146;146;147;147;146;147;146 12:25:50 INFO - PROCESS | 24035 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 12:25:50 INFO - PROCESS | 24035 | |8;json-parse-financial;53;52;51;52;52;51;52;52;52;51 12:25:50 INFO - PROCESS | 24035 | |9;json-stringify-tinderbox;62;63;62;62;62;62;62;62;66;61 12:25:50 INFO - PROCESS | 24035 | |10;stanford-crypto-aes;76;88;75;75;84;75;75;75;76;84 12:25:50 INFO - PROCESS | 24035 | |11;stanford-crypto-ccm;121;128;117;137;119;121;128;122;159;121 12:25:50 INFO - PROCESS | 24035 | |12;stanford-crypto-pbkdf2;154;158;152;152;153;156;153;153;152;153 12:25:50 INFO - PROCESS | 24035 | |13;stanford-crypto-sha256-iterative;62;62;64;61;63;66;62;63;62;62 12:25:50 INFO - PROCESS | 24035 | __end_tp_report 12:25:50 INFO - PROCESS | 24035 | __start_cc_report 12:25:50 INFO - PROCESS | 24035 | _x_x_mozilla_cycle_collect,1663 12:25:50 INFO - PROCESS | 24035 | __end_cc_report 12:25:50 INFO - PROCESS | 24035 | __startTimestamp1468437950963__endTimestamp 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | ------- Summary: start ------- 12:25:50 INFO - PROCESS | 24035 | Number of tests: 14 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.31 (2.9%) stddev-sans-first:0.93 12:25:50 INFO - PROCESS | 24035 | Values: 102.0 113.0 112.0 111.0 113.0 113.0 112.0 113.0 111.0 111.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:133.50 stddev:20.28 (15.2%) stddev-sans-first:21.24 12:25:50 INFO - PROCESS | 24035 | Values: 143.0 116.0 120.0 175.0 124.0 124.0 146.0 118.0 157.0 117.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 12:25:50 INFO - PROCESS | 24035 | Values: 161.0 161.0 161.0 160.0 160.0 162.0 164.0 164.0 160.0 161.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.00 stddev:21.68 (28.9%) stddev-sans-first:22.72 12:25:50 INFO - PROCESS | 24035 | Values: 75.0 76.0 76.0 140.0 75.0 76.0 74.0 74.0 105.0 74.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:83.00 stddev:21.45 (25.8%) stddev-sans-first:22.21 12:25:50 INFO - PROCESS | 24035 | Values: 83.0 83.0 113.0 84.0 83.0 85.0 122.0 85.0 83.0 142.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 12:25:50 INFO - PROCESS | 24035 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 118.0 116.0 117.0 116.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:25:50 INFO - PROCESS | 24035 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:25:50 INFO - PROCESS | 24035 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 12:25:50 INFO - PROCESS | 24035 | Values: 53.0 52.0 51.0 52.0 52.0 51.0 52.0 52.0 52.0 51.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 12:25:50 INFO - PROCESS | 24035 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 66.0 61.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:76.00 stddev:4.99 (6.6%) stddev-sans-first:5.22 12:25:50 INFO - PROCESS | 24035 | Values: 76.0 88.0 75.0 75.0 84.0 75.0 75.0 75.0 76.0 84.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.00 stddev:12.57 (10.1%) stddev-sans-first:13.12 12:25:50 INFO - PROCESS | 24035 | Values: 121.0 128.0 117.0 137.0 119.0 121.0 128.0 122.0 159.0 121.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.00 stddev:1.96 (1.3%) stddev-sans-first:2.07 12:25:50 INFO - PROCESS | 24035 | Values: 154.0 158.0 152.0 152.0 153.0 156.0 153.0 153.0 152.0 153.0 12:25:50 INFO - PROCESS | 24035 | 12:25:50 INFO - PROCESS | 24035 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.42 (2.3%) stddev-sans-first:1.48 12:25:50 INFO - PROCESS | 24035 | Values: 62.0 62.0 64.0 61.0 63.0 66.0 62.0 63.0 62.0 62.0 12:25:50 INFO - PROCESS | 24035 | -------- Summary: end -------- 12:25:50 INFO - PROCESS | 24035 | 12:25:51 INFO - TEST-INFO | 24035: exit 0 12:25:52 INFO - TEST-OK | kraken | took 60843ms 12:25:52 INFO - SUITE-END | took 1174s 12:25:52 INFO - Completed test suite (00:19:34) 12:25:52 INFO - javascript benchmark 12:25:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.6701462839083, 3005.98497007515, 3022.9848850755748, 3047.360054388578, 3067.8159310441374, 5222.660527065738, 5274.4198138204865, 5276.577873770098, 5353.411124776277, 5393.029254734146, 5259.447757985405, 5267.947320526793, 5271.0, 5337.519623233918, 5349.170878513836, 4795.0, 4855.975720121394, 4880.048390563841, 4894.681845680037, 5069.087564238435, 4970.130227210242, 4994.900101997958, 4995.900081998358, 5049.64652474327, 5064.442911279756, 4787.9521204788025, 4793.137235297645, 4875.341828853095, 4921.950780492203, 4923.384576927884, 4782.473927867932, 4794.736289504111, 4799.064182484417, 4864.318995340655, 4906.828261010884, 4818.325434439182, 4826.951730482685, 4834.54071863176, 4845.878853028667, 4860.246661767432, 5139.897202055975, 5323.095073837457, 5390.757415916293, 5445.0, 5456.317960254968, 5760.164776107483, 5780.624259423124, 5788.334341550733, 5810.3899090595305, 5811.331696854873, 5499.202615620713, 5603.355614104389, 5842.766289348463, 5856.736446859902, 5857.85355366115, 5349.839504814861, 5363.678179309254, 5412.702301373423, 5432.103702889019, 5438.45615438453, 5889.352171261158, 5890.528757699374, 5890.793822216202, 5891.263592050994, 5919.733611987471, 5364.409914909357, 5504.559635229172, 5684.403137670485, 5687.971560142173, 5690.231818704505, 5726.169705392695, 5765.1928729977835, 5796.536277097822, 5802.738876750472, 5803.7388317524965, 5588.91616625751, 5599.804006859822, 5611.270534830527, 5621.747021384048, 5700.771969121189, 5478.671279723229, 5572.888542229132, 5615.606907516516, 5704.971475142598, 5718.599698021098, 4303.376010478463, 4314.654827613784, 4317.352397140391, 4349.499807522112, 4354.978225108917, 3812.3709587917683, 3822.7515211511163, 3839.328117579468, 3865.6520913117956, 3884.1260716338597, 5228.607854410934, 5235.424103348629, 5330.706811125426, 5368.0, 5374.086405311106, 5670.5463562914865, 5689.9146512802345, 5696.0, 5697.373288938214, 5714.257146570919, 5325.254464374991, 5415.48552887475, 5418.1330987042675, 5424.213489044146, 5429.619926605179, 4812.278158276286, 4833.347498087784, 4843.128236917319, 4888.120138375127, 4921.581665558396, 5799.623024503394, 5801.361850196475, 5803.187553742479, 5804.854878627983, 5827.7668893244645, 5629.26819513477, 5666.15007748841, 5687.289088863892, 5687.5734319927, 5692.203091567267, 5807.274090738658, 5845.41545845412, 5880.206172166874, 5906.468417842415, 5931.792387266425, 5640.0, 5640.971795140998, 5644.887102258014, 5648.124540696199, 5651.717414129359, 5496.0, 5683.715814209356, 5756.481916627524, 5759.222504961776, 5764.654120752768, 5436.456354364532, 5480.588955828249, 5486.259354987025, 5495.258140151029, 5514.80698175562, 5456.181572764117, 5466.72666366688, 5477.643953143033, 5487.341519017744, 5489.149181876815, 5363.624546281723, 5376.919346209888, 5420.2140689599, 5436.700981446058, 5476.72616369172, 5605.943940560543, 5660.405657406078, 5667.263255776723, 5703.914441283467, 5716.114002329646, 5483.75323110453, 5489.698066606375, 5498.037843377473, 5510.476504732044, 5524.281843360337], "value": 5246.542717750735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5849446892706, 616.4790751814717, 627.5450298533563, 629.6945981199118, 633.9049142628602, 33484.330313393715, 36834.263314733726, 36856.44715329269, 36974.8151259244, 43640.563594364125, 41887.79056104723, 46634.30048549274, 46789.766051169696, 46976.76511617446, 47044.764776176155, 8885.111488851127, 9070.77323066922, 9074.455532668027, 9076.546172691373, 9083.909160908406, 8986.14631609996, 9066.863997040049, 9069.229115525188, 9072.31957603179, 9105.63577456901, 9072.63709451621, 9134.77163070922, 9138.817223655524, 9138.862917056249, 9142.451452912814, 9035.232005279526, 9076.319276054257, 9081.54592270384, 9090.954545227298, 9092.181703646704, 8948.73153805387, 9034.503102329369, 9036.50299233542, 9036.728898133066, 9038.141376569216, 43024.3546346805, 43294.0, 43404.0, 43460.696179114675, 43475.34786978198, 3440.6753399940953, 3487.7384196185135, 3528.311979164064, 3577.141486043357, 3612.9096772580633, 33165.834170829236, 33232.501512477334, 33551.16122096943, 33729.32541349159, 34357.312853742784, 4413.624841888443, 4482.8879278017985, 4483.417155769729, 4505.301678239878, 4604.424446944132, 378860.4227915454, 379771.0, 379773.0, 381701.0, 385732.0, 59699.701501492214, 60401.39598604046, 60419.0, 60502.46231532653, 60521.0, 35916.281674366364, 36885.26229475396, 36969.81515092461, 38414.80792596075, 38439.0, 16559.503214903572, 16638.75041874373, 16707.331706731595, 16722.414715484898, 16756.0, 12622.87377126217, 12721.427535760913, 12722.173058751152, 12728.109032367645, 12733.236005839679, 19882.0, 19947.102380392917, 20000.699989500168, 20059.197632094845, 20135.0, 7148.142222933281, 7170.435190873678, 7269.781906542812, 7307.525010874276, 7483.251674832473, 985.5269470654126, 1090.929089609173, 1102.7629059752032, 1106.634810512529, 1133.4955944604571, 33786.49320260198, 33882.66117338795, 33890.0, 34700.82649586736, 34750.652493475245, 936.2930987104693, 1059.9523021464054, 1106.5020740666732, 1128.2215271462665, 1185.9407029648482, 16324.75512867308, 16580.17099145038, 16691.49925502237, 16880.915595421946, 17069.31722731077, 558078.0, 562513.0, 564956.0, 565117.0, 566223.0, 53794.0, 54929.72535137299, 54997.0, 55077.0, 55128.17307740387, 1108.7948729485072, 1317.5981325695564, 1346.8585798491213, 1385.6605131742585, 1397.8881689465022, 32061.0, 34017.82991085128, 34150.82924585361, 34183.0, 34885.476717848745, 49453.0, 50147.49852501574, 50174.2473862885, 50223.49776502188, 50399.74800125976, 419605.0, 423623.0, 424292.0, 426003.0, 761704.0, 27787.861060694566, 28187.71812281851, 28307.584620769292, 29200.853995729885, 29236.707632923397, 47593.0, 48371.75814121048, 49004.0, 49165.0, 49634.75182624064, 39610.40584391179, 40950.38574421446, 41081.79459102685, 41767.16465670609, 42283.577164227965, 40563.59436405598, 41420.79289603653, 41580.0, 41717.0, 41896.371554427315, 40588.594114058484, 41348.0, 41506.1698766029, 41716.58283417127, 41870.790646046575, 34220.82889585536, 36375.63624363722, 36613.26773464569, 37495.62504374921, 37499.0, 28075.859620701765, 28270.455658990788, 28430.627748900606, 28463.0, 28960.42079158447], "value": 20163.756907465442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.16225074707285, 382.14018458468445, 389.51505375807113, 393.87592908233904, 410.09573889573494, 17900.0, 19888.105035273413, 19892.50268743282, 19999.700004499926, 20056.398308050782, 18916.81083189168, 19324.0, 19618.41144765656, 19806.504837379074, 19906.800931990674, 5432.076546987022, 5739.713014349297, 5924.674142922137, 5936.109583562457, 5945.197398351211, 5813.128030795372, 5814.680192589406, 5825.7378417971295, 5865.296164460271, 5877.324107727602, 5666.5183459406, 5674.716264186774, 5792.275965504312, 5793.826185214451, 5855.736491857877, 5733.741981610796, 5811.4479124483105, 5822.155787410844, 5828.2131912191735, 5850.88298234035, 5035.0685123252315, 5155.149400348938, 5192.636515443921, 5192.792288308463, 5206.401263854667, 23601.763982360128, 23645.76354236453, 23704.525909481887, 24444.633330500055, 24481.143159989315, 2213.734351877785, 2361.1381845626393, 2443.9389015274583, 2514.0823599386276, 2633.473305338921, 14525.765309948667, 14949.103053816805, 15089.54731358061, 15322.0, 15506.0, 1826.0960824391877, 1865.0861078071782, 1888.4901076709211, 1943.630710165064, 1952.6290004899024, 76916.61541692312, 79274.0, 81257.0, 81727.0, 81959.59020204861, 10498.002689744462, 10659.360438373722, 10721.142308615292, 10975.50610222542, 10992.340459572451, 14840.18378989166, 14948.476803312049, 14973.70052598942, 14987.100773953598, 15012.0, 8008.799780005546, 8104.27061564462, 8228.711995080144, 8310.958445207736, 8357.206065423776, 7898.249666281694, 7961.482503637245, 7967.601619918981, 8084.676612935416, 8199.42604017725, 6581.473482121419, 6623.4701223901975, 6642.7342906284175, 6746.265674177009, 6842.93157068423, 1878.3238034307637, 1892.1485331600834, 1950.8927009014355, 1990.1442379776836, 1991.1924186896406, 932.6455946740195, 951.9524023798782, 997.4314640654757, 1022.5756311130946, 1023.5240613114937, 20163.193472260944, 20427.182912683325, 20549.89725051395, 20563.588728225353, 20634.0, 997.4613708597421, 1004.5830980143159, 1005.9647912323034, 1044.738815296176, 1104.5526561742506, 11074.723131921604, 11768.176227663982, 11818.586349477728, 11828.645140645795, 11839.171258011856, 466751.0, 469089.0, 481161.0, 482783.0, 490059.0, 83626.0, 84278.0, 84522.5773871139, 85484.57257713671, 85602.4397560239, 1037.1339931157568, 1052.8052310322614, 1079.6707004363745, 1109.1958330210693, 1109.517359948425, 17762.733558996882, 18021.0, 18326.26694932241, 18476.136198889195, 18693.15880785395, 38575.0, 39425.0, 40142.39786403148, 40263.79868100641, 40616.0, 52073.689088651685, 52548.211776822616, 53562.0, 53771.19343209777, 54165.18752218799, 8611.268042216481, 8638.093000234885, 8830.410526105363, 8844.955775221082, 9001.954990225007, 13312.534061307808, 13482.325883705971, 13511.797323039966, 13525.18848869071, 13722.519711810039, 11067.778644427228, 11646.534138634359, 11728.41357932083, 11994.280343179436, 12082.758344832879, 11860.466279017292, 11902.821457677968, 12022.458989345325, 12083.39583020863, 12245.69385765363, 11933.0, 12009.339486328336, 12040.0, 12189.51241950312, 12471.314077725448, 8502.44734092282, 8627.6980305689, 8687.956560217412, 8849.734507964771, 8962.058983806866, 10882.0, 10893.945530272298, 11888.643340699793, 11929.582464613697, 12056.879431205927], "value": 9456.919312228278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.3349058961112, 1498.2658497336301, 1536.0553259745257, 1658.8921720088194, 1818.2817786974147, 8541.615627296778, 9006.864897026542, 9023.458592484456, 9207.769805754859, 9224.584893679783, 8912.420692654989, 9096.63613455461, 9103.0, 9107.408018478794, 9125.49809760463, 2034.9389518314474, 2088.728465299509, 2097.769245383007, 2356.1164563288767, 2381.5117900830373, 1965.4594986378718, 2173.2936795541514, 2239.5744808486334, 2242.3497185816095, 2258.695076164713, 2371.9407014824596, 2379.6192609182535, 2395.9520809583796, 2396.7842894139526, 2396.9161079362225, 1984.771751248596, 2343.1330407749156, 2345.683332750091, 2348.0842471436154, 2351.576716191085, 2277.567262220173, 2324.1749179041367, 2326.9650955235684, 2358.8348815582917, 2366.0535785685865, 9008.864867027, 9083.863742043875, 9108.817823643556, 9129.863052054225, 9165.679201227926, 5070.264811602334, 5148.279240906276, 5161.148410512261, 5164.173732202867, 5168.198929165986, 3462.480627905809, 3467.1158854492196, 3493.777696537349, 3600.5499312585926, 3618.5476815398074, 1158.362900404774, 1159.0727418065599, 1161.1233518693416, 1163.8661553921238, 1171.2035815645443, 12255.69360765979, 12293.938530307381, 12299.954503867182, 12302.200356976768, 12420.875791242062, 4468.240399132155, 4478.7760611969925, 4657.022025374641, 4669.696469729524, 4733.219018861849, 10295.94852025735, 10326.070653641209, 10335.483225838678, 10337.896621033844, 10343.01741334572, 5300.204969254565, 5313.415524292402, 5376.032314183406, 5383.300170977748, 5384.461553844662, 4837.274408838632, 4913.950860491421, 4938.185199442052, 4940.530649588283, 5000.6249531284575, 3783.45139954705, 3808.1431677872256, 3854.7494412863634, 3897.824597893102, 3903.6486716195677, 1098.2092893116942, 1098.2916019167592, 1117.8435019097333, 1120.8094623913955, 1139.7834411461795, 973.634886917406, 978.2076518020284, 989.8465737810651, 997.6408492942535, 1002.1331548210745, 5885.852853678607, 5888.0, 5977.0, 6130.478909292671, 6186.783462578788, 448.3789950918002, 457.1063570719236, 458.00155660659414, 458.6239283787329, 461.7414248021119, 3982.6216509431556, 4181.519125300569, 4209.915801683949, 4217.4306468626955, 4287.464066991626, 11132.0, 11515.884841151481, 11526.538938442536, 11568.76862462746, 11593.6521904343, 10763.19276054299, 11146.164037697205, 11163.106951443864, 11449.141314401453, 11474.655760327203, 8396.580170991427, 8499.532525711145, 8531.616077276538, 8537.274331681876, 8581.570921453902, 6048.637081775108, 6313.842153946188, 6404.327545607644, 6445.097686323825, 6484.967575162094, 10290.845637315297, 10499.370037797757, 10597.993190646876, 10625.468726563795, 10692.679219623424, 9516.095970882756, 10791.838122428013, 11062.0, 11079.889201108208, 11083.833742494031, 7910.7231246906085, 8269.00771907375, 8276.958615207126, 8497.362697797565, 8500.149985001697, 8685.91314086851, 8700.086490918362, 8700.956495217484, 8709.433886797338, 8881.600327985385, 7885.053793544811, 7918.406119540942, 8050.194980501903, 8077.959610201911, 8149.79625509367, 7972.84054318922, 8061.4760040597175, 8098.878516822135, 8103.8379232413845, 8205.056418511947, 7472.439567032603, 7478.439117066133, 7500.699972001277, 7543.0948286206, 7545.547267163988, 4586.564276393738, 5194.532492075731, 5213.452587478412, 5323.787048518016, 5444.646098003617, 5406.756695948613, 5477.1510415885605, 5493.203485494501, 5518.972405137949, 5739.397363276796], "value": 4625.287609310224, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.98317092559915, 308.8671871095429, 313.78819296974535, 315.17581524313914, 315.2717223214375, 5218.008578370107, 5244.160934250521, 5260.789568417268, 5263.210518422234, 5303.363596368436, 4974.2538619207135, 5025.246213068032, 5203.829138443848, 5207.739613019353, 5210.9478905210935, 4036.132231570212, 4079.4288799567935, 4087.4686290782156, 4098.159877225176, 4107.712460127792, 4082.3060079786505, 4087.9591204087874, 4099.7745124018165, 4103.076807718255, 4116.094459218967, 3760.02239417752, 3884.9223015539674, 4006.479157709494, 4007.2786898358286, 4070.715049946505, 4011.939820902689, 4031.8185681644395, 4036.1120553478186, 4059.1881623675235, 4062.1266427718033, 3563.1626567756557, 3563.4476656118345, 3564.4296912494137, 3564.893053208382, 3566.857325706969, 4898.485659005824, 5094.59243260542, 5096.413912400084, 5146.511081447256, 5164.509371609691, 4569.326943737918, 4579.67942244043, 4601.792919318638, 4603.010352774136, 4603.792829322655, 5461.5357694596005, 5473.17902314652, 5488.353493951799, 5496.80761173357, 5500.80747173851, 3669.559652841676, 3863.111484358585, 3863.3239183142837, 3866.3040652682507, 3871.9032024199337, 5629.4652008059575, 5630.971845140789, 5651.689157096358, 5663.207150998864, 5689.345725241609, 3924.4898163238595, 3963.524377074712, 3967.6032396760093, 3969.166475040216, 3972.602739726004, 3928.9607103929166, 4012.973448408535, 4016.4376987221813, 4019.336809426412, 4022.3363145080734, 4575.2450845610765, 4580.679352445363, 4594.33382159585, 4602.861914142581, 4618.284165954283, 5431.2396264522995, 5435.320584926884, 5464.3442786865835, 5469.535089517435, 5541.92423205125, 1258.3456602566614, 1317.1504379675248, 1352.891768658505, 1369.1511263016994, 1369.6165073779357, 948.7153853843819, 973.1436336024253, 975.3952549419264, 976.6972238606055, 977.9559919803626, 5228.529432351107, 5240.737963101829, 5264.947350526522, 5294.444083371268, 5300.575953923677, 5573.41479144692, 5575.303087114111, 5598.300212473441, 5599.412061733459, 5626.85932851682, 5074.2895994560795, 5366.6243362965, 5374.4739972213, 5379.5427388671615, 5382.381026181961, 2937.6474823021376, 2967.9018763057807, 2974.985125074361, 2987.268119310783, 2992.5660779186896, 5612.071549915076, 5733.541316694655, 5771.826845194651, 5772.278465191851, 5799.652020878676, 5691.243779105853, 5704.486596206361, 5728.255326807488, 5770.16332631766, 5792.594518383673, 5762.0, 5787.189793428924, 5836.474717275466, 5847.736851841677, 5875.148103525051, 5528.44715528444, 5668.093105103164, 5677.091665333527, 5678.858028549154, 5689.800856969986, 5554.833354999357, 5577.74900129487, 5592.664440133605, 5616.427400327915, 5631.211630371669, 5620.4098569649595, 5821.70891455417, 5823.82528524145, 5829.775747092988, 5870.324912634931, 3762.94355584661, 3907.7264591478324, 3908.2183563288027, 3910.240391823748, 3920.4903362562686, 5430.235173568685, 5631.183478395692, 5634.971825141012, 5646.475451628119, 5651.06144804691, 5478.753456094406, 5493.642913210629, 5518.255035570147, 5521.475459831309, 5527.834164975057, 5254.343207099113, 5491.533219676372, 5521.3926468089285, 5530.198121272312, 5536.75084621201, 5387.030334539821, 5393.27190829233, 5409.594280429063, 5414.269073675004, 5435.157550579666, 5479.369872464717, 5497.752601132878, 5507.118860982224, 5527.8894422110525, 5533.142362933751, 5272.7100009499845, 5334.573234141337, 5381.627684940472, 5434.619576629598, 5440.863978400572], "value": 4160.866332216341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1349846438114, 762.0931092000517, 792.6948124971888, 814.600845585663, 839.9207018980611, 14315.642108947282, 15105.244737763109, 15490.767638485431, 16201.10893900835, 16251.268692908818, 13683.384247708853, 13695.246761428118, 13851.030427870053, 13873.861261387383, 13909.860901390983, 679.6839469646613, 805.6737021506285, 823.7240524424295, 823.8887750153713, 824.6742536698001, 795.2087672765606, 821.9013718353806, 823.7117009046816, 826.9379796515256, 827.5820710541199, 842.1157784326464, 842.5113434208145, 845.8604330285496, 846.0946786937978, 846.5090247656344, 693.4002088193727, 718.6227230703922, 838.6938767349934, 838.7357982235576, 841.6927821345196, 525.2672521832061, 525.5795363709018, 607.2530787131808, 624.7157543317779, 627.8618703885138, 12598.37008149598, 12701.174423662525, 12729.681757956032, 12777.680557986032, 12778.680532986657, 14339.928300358535, 14406.639834004234, 14645.926770366186, 14671.248022926648, 14929.701405971928, 13347.799783003262, 13482.662933426645, 13619.795703064461, 13622.863771362358, 14189.929050354682, 4555.612772914306, 4612.077584483083, 4641.071785642885, 4715.174844402216, 4790.041991601659, 33185.83407082949, 33437.665623343695, 33438.83280583606, 33439.83280083584, 33441.83279083613, 11130.165237607212, 11335.716607084723, 11522.308661480338, 11937.61307381844, 11980.101492388107, 20150.69773953392, 20151.395458135987, 20168.19327226924, 20171.394858153984, 20176.89911550433, 8192.385571082194, 8256.587170641444, 8265.46274492156, 8266.751997439966, 8295.502269863828, 4523.185826551252, 4830.082284365959, 4838.903221935541, 4842.927356089662, 4852.199387101089, 3505.8422370993367, 3585.515955345995, 3590.676839084495, 3601.6218297078954, 3610.6028336882923, 603.0712702438196, 626.2453743239386, 626.7680958045553, 627.6516533324049, 628.0391001767304, 665.8535122273092, 711.4877288352378, 732.209214048826, 746.3831598536917, 782.8590853646284, 9235.010337698117, 9527.38034534131, 9729.70810875675, 9732.0, 9903.356281841658, 604.9969750151221, 612.3998481488167, 701.2251462134268, 724.5580196080386, 740.6629983357559, 4263.0, 4674.252119660838, 4697.812087516461, 4750.643701722384, 4756.167670657621, 65615.0, 81209.0, 117319.0, 124335.37832310781, 124479.0, 105529.47235263775, 105870.0, 106311.0, 107621.0, 107782.46108769406, 53167.20249196265, 62796.0, 70577.64711176412, 89339.55330223308, 91090.0, 9082.818343632958, 9241.537923103684, 9252.213561847318, 9291.62833486653, 9323.114304141096, 53642.0, 53775.46224537861, 53976.730116349165, 54241.45758542364, 54511.0, 72137.63931180311, 74626.62686686532, 80057.59971200107, 82196.58901705453, 83330.0, 11074.224804263624, 11095.11239100886, 11119.44402779874, 11271.04196143337, 11776.352300623548, 12976.0, 13034.413451394521, 13159.802602961156, 13271.933640331736, 13347.532836350681, 10933.945330273616, 12112.091593130726, 12398.504059837505, 12474.438650260941, 12540.310282934526, 13675.79486307726, 13971.441142354191, 14292.785608215678, 14374.137551746928, 14949.327280272197, 13954.79067814004, 13968.58094257174, 14151.43394264259, 14178.220197888802, 14651.487197948021, 11149.0, 11492.425378730863, 11672.299662020307, 11774.52901883915, 12010.216781713732, 10950.0, 11752.823707644564, 11802.645920622395, 12015.81976270374, 12272.631821045383], "value": 7294.72604268331, "unit": "score"}], "name": "dromaeo_css", "value": 7209.891740030898, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 111.0, 113.0, 113.0, 112.0, 113.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 120.0, 175.0, 124.0, 124.0, 146.0, 118.0, 157.0, 117.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 164.0, 164.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 140.0, 75.0, 76.0, 74.0, 74.0, 105.0, 74.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 84.0, 83.0, 85.0, 122.0, 85.0, 83.0, 142.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 66.0, 61.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 88.0, 75.0, 75.0, 84.0, 75.0, 75.0, 75.0, 76.0, 84.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 117.0, 137.0, 119.0, 121.0, 128.0, 122.0, 159.0, 121.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 152.0, 152.0, 153.0, 156.0, 153.0, 153.0, 152.0, 153.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 61.0, 63.0, 66.0, 62.0, 63.0, 62.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1481.8999999999999, "alertThreshold": 2.0}]} 12:25:52 INFO - Return code: 0 12:25:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:25:52 INFO - # TBPL SUCCESS # 12:25:52 INFO - Running post-action listener: _resource_record_post_action 12:25:52 INFO - ##### 12:25:52 INFO - ##### Finished run-tests step (success) 12:25:52 INFO - ##### 12:25:52 INFO - Running post-run listener: _resource_record_post_run 12:25:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 574930944; Read time: 8; Write time: 588456 12:25:52 INFO - TinderboxPrint: CPU usage
13.0% 12:25:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:25:52 INFO - TinderboxPrint: I/O write bytes / time
574,930,944 / 588,456 12:25:52 INFO - TinderboxPrint: CPU idle
8,271.2 (86.9%) 12:25:52 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 12:25:52 INFO - TinderboxPrint: Swap in / out
0 / 0 12:25:52 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256966656; Read time: 0; Write time: 335232 12:25:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296452096; Read time: 0; Write time: 247876 12:25:52 INFO - Running post-run listener: _upload_blobber_files 12:25:52 INFO - Blob upload gear active. 12:25:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:25:52 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 12:25:52 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'] 12:25:52 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 12:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:56 INFO - (blobuploader) - INFO - Done attempting. 12:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:25:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:25:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:57 INFO - (blobuploader) - INFO - Done attempting. 12:25:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:25:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:57 INFO - (blobuploader) - INFO - Done attempting. 12:25:57 INFO - (blobuploader) - INFO - Iteration through files over. 12:25:57 INFO - Return code: 0 12:25:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:25:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:25:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cafe6a3724d9959244f7f97d56f8a12d770ce7273676e980db280ecd358b807c723b50a5434f94364d8861748162321ab71ecc45f9f75ae3ac06da890b79c96a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a9b1ba65195010581999d8ac81e6e655c614c0c1c3d39ee480b50da11f600163b7e675a3984701531f69ce747bde5bed070c80aed9c86e125071610c5f698b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e088c810af1ff74f1975cff018fb8dfea93c15f65cc561c3af80b818db1204668df4547ae440d0e51c7df9b3c65282ba6974b818be0982ce97cdf2628cc0ff3"} 12:25:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:25:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:25:57 INFO - Contents: 12:25:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cafe6a3724d9959244f7f97d56f8a12d770ce7273676e980db280ecd358b807c723b50a5434f94364d8861748162321ab71ecc45f9f75ae3ac06da890b79c96a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a9b1ba65195010581999d8ac81e6e655c614c0c1c3d39ee480b50da11f600163b7e675a3984701531f69ce747bde5bed070c80aed9c86e125071610c5f698b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e088c810af1ff74f1975cff018fb8dfea93c15f65cc561c3af80b818db1204668df4547ae440d0e51c7df9b3c65282ba6974b818be0982ce97cdf2628cc0ff3"} 12:25:57 INFO - Running post-run listener: copy_logs_to_upload_dir 12:25:57 INFO - Copying logs to upload dir... 12:25:57 INFO - mkdir: /builds/slave/test/build/upload/logs 12:25:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.931441 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-13 12:25:57.295748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 12:25:57.298986) ========= 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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cafe6a3724d9959244f7f97d56f8a12d770ce7273676e980db280ecd358b807c723b50a5434f94364d8861748162321ab71ecc45f9f75ae3ac06da890b79c96a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a9b1ba65195010581999d8ac81e6e655c614c0c1c3d39ee480b50da11f600163b7e675a3984701531f69ce747bde5bed070c80aed9c86e125071610c5f698b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e088c810af1ff74f1975cff018fb8dfea93c15f65cc561c3af80b818db1204668df4547ae440d0e51c7df9b3c65282ba6974b818be0982ce97cdf2628cc0ff3"} build_url:https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/cSBRAyEfQxqjc-3Zve_cvQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cafe6a3724d9959244f7f97d56f8a12d770ce7273676e980db280ecd358b807c723b50a5434f94364d8861748162321ab71ecc45f9f75ae3ac06da890b79c96a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a9b1ba65195010581999d8ac81e6e655c614c0c1c3d39ee480b50da11f600163b7e675a3984701531f69ce747bde5bed070c80aed9c86e125071610c5f698b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e088c810af1ff74f1975cff018fb8dfea93c15f65cc561c3af80b818db1204668df4547ae440d0e51c7df9b3c65282ba6974b818be0982ce97cdf2628cc0ff3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 12:25:57.324381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:25:57.324717) ========= 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=52faae308a556c440401f8e5000001e8-1468436724.943268-890611768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 12:25:57.407440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 12:25:57.407765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 12:25:57.408071) ========= ========= Total master_lag: 0.14 =========