builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1467382652.9 results: success (0) buildid: 20160701043016 builduid: e93e794718c64cea9ae0f7764ac10c2c revision: f531396cd66b517efa632d0d61db3b6a569ba6ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:32.898172) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:32.898724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:32.899085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:32.924293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:32.924618) ========= 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=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 07:17:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.3M=0.001s 2016-07-01 07:17:33 (22.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.052705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.053137) ========= 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=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014863 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.105027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.105544) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f531396cd66b517efa632d0d61db3b6a569ba6ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f531396cd66b517efa632d0d61db3b6a569ba6ae --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=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 07:17:33,196 truncating revision to first 12 chars 2016-07-01 07:17:33,196 Setting DEBUG logging. 2016-07-01 07:17:33,197 attempt 1/10 2016-07-01 07:17:33,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f531396cd66b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 07:17:33,496 unpacking tar archive at: mozilla-inbound-f531396cd66b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.756416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.756873) ========= script_repo_revision: f531396cd66b517efa632d0d61db3b6a569ba6ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.757451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.757826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:17:33.769713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-01 07:17:33.770338) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:33 INFO - MultiFileLogger online at 20160701 07:17:33 in /builds/slave/test 07:17:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:17:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:33 INFO - {'append_to_log': False, 07:17:33 INFO - 'base_work_dir': '/builds/slave/test', 07:17:33 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:17:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:33 INFO - 'branch': 'Mozilla-Inbound', 07:17:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:33 INFO - 'config_files': ('talos/linux_config.py',), 07:17:33 INFO - 'default_actions': ('clobber', 07:17:33 INFO - 'read-buildbot-config', 07:17:33 INFO - 'download-and-extract', 07:17:33 INFO - 'populate-webroot', 07:17:33 INFO - 'create-virtualenv', 07:17:33 INFO - 'install', 07:17:33 INFO - 'run-tests'), 07:17:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:33 INFO - 'download_minidump_stackwalk': True, 07:17:33 INFO - 'download_symbols': 'ondemand', 07:17:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:33 INFO - 'installer_path': 'installer.exe', 07:17:33 INFO - 'log_level': 'info', 07:17:33 INFO - 'log_name': 'talos', 07:17:33 INFO - 'log_to_console': True, 07:17:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:33 INFO - 'opt_config_files': (), 07:17:33 INFO - 'pip_index': False, 07:17:33 INFO - 'sps_profile': False, 07:17:33 INFO - 'sps_profile_interval': 0, 07:17:33 INFO - 'suite': 'dromaeojs', 07:17:33 INFO - 'system_bits': '32', 07:17:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:33 INFO - 'title': 'talos-linux64-ix-017', 07:17:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:33 INFO - 'use_talos_json': True, 07:17:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:33 INFO - 'work_dir': 'build'} 07:17:33 INFO - ##### 07:17:33 INFO - ##### Running clobber step. 07:17:33 INFO - ##### 07:17:33 INFO - Running pre-action listener: _resource_record_pre_action 07:17:33 INFO - Running main action method: clobber 07:17:33 INFO - rmtree: /builds/slave/test/build 07:17:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:34 INFO - Running post-action listener: _resource_record_post_action 07:17:34 INFO - ##### 07:17:34 INFO - ##### Finished clobber step (success) 07:17:34 INFO - ##### 07:17:34 INFO - ##### 07:17:34 INFO - ##### Running read-buildbot-config step. 07:17:34 INFO - ##### 07:17:34 INFO - Running pre-action listener: _resource_record_pre_action 07:17:34 INFO - Running main action method: read_buildbot_config 07:17:34 INFO - Using buildbot properties: 07:17:34 INFO - { 07:17:34 INFO - "project": "", 07:17:34 INFO - "product": "firefox", 07:17:34 INFO - "script_repo_revision": "production", 07:17:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:17:34 INFO - "repository": "", 07:17:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:17:34 INFO - "buildid": "20160701043016", 07:17:34 INFO - "pgo_build": "True", 07:17:34 INFO - "basedir": "/builds/slave/test", 07:17:34 INFO - "buildnumber": 2009, 07:17:34 INFO - "slavename": "talos-linux64-ix-017", 07:17:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:34 INFO - "platform": "ubuntu64_hw", 07:17:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:17:34 INFO - "branch": "mozilla-inbound", 07:17:34 INFO - "repo_path": "integration/mozilla-inbound", 07:17:34 INFO - "revision": "f531396cd66b517efa632d0d61db3b6a569ba6ae", 07:17:34 INFO - "stage_platform": "linux64-pgo", 07:17:34 INFO - "builduid": "e93e794718c64cea9ae0f7764ac10c2c", 07:17:34 INFO - "slavebuilddir": "test" 07:17:34 INFO - } 07:17:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:17:34 INFO - Running post-action listener: _resource_record_post_action 07:17:34 INFO - ##### 07:17:34 INFO - ##### Finished read-buildbot-config step (success) 07:17:34 INFO - ##### 07:17:34 INFO - ##### 07:17:34 INFO - ##### Running download-and-extract step. 07:17:34 INFO - ##### 07:17:34 INFO - Running pre-action listener: _resource_record_pre_action 07:17:34 INFO - Running main action method: download_and_extract 07:17:34 INFO - mkdir: /builds/slave/test/build/tests 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:34 INFO - https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:17:36 INFO - Downloaded 1361 bytes. 07:17:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:17:36 INFO - Using the following test package requirements: 07:17:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:17:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'jsshell-linux-x86_64.zip'], 07:17:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:36 INFO - https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:37 INFO - Downloaded 24271603 bytes. 07:17:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:17:38 INFO - Return code: 0 07:17:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:38 INFO - https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:40 INFO - Downloaded 24271603 bytes. 07:17:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:17:41 INFO - Return code: 0 07:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:41 INFO - https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:17:42 INFO - Downloaded 14405327 bytes. 07:17:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:17:42 INFO - Return code: 0 07:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:42 INFO - https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:17:44 INFO - Downloaded 60354225 bytes. 07:17:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:17:44 INFO - mkdir: /builds/slave/test/properties 07:17:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:44 INFO - Contents: 07:17:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:17:44 INFO - Running post-action listener: _resource_record_post_action 07:17:44 INFO - Running post-action listener: set_extra_try_arguments 07:17:44 INFO - ##### 07:17:44 INFO - ##### Finished download-and-extract step (success) 07:17:44 INFO - ##### 07:17:44 INFO - ##### 07:17:44 INFO - ##### Running populate-webroot step. 07:17:44 INFO - ##### 07:17:44 INFO - Running pre-action listener: _resource_record_pre_action 07:17:44 INFO - Running main action method: populate_webroot 07:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:44 INFO - '--tppagecycles', 07:17:44 INFO - '7'], 07:17:44 INFO - 'tests': ['tsvgm']}}, 07:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['damp', 'tps']}, 07:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['damp', 'tps']}, 07:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['dromaeo_dom']}, 07:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['basic_compositor_video']}, 07:17:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['a11yr', 07:17:44 INFO - 'ts_paint', 07:17:44 INFO - 'tpaint', 07:17:44 INFO - 'sessionrestore', 07:17:44 INFO - 'sessionrestore_no_auto_restore', 07:17:44 INFO - 'tabpaint']}, 07:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tsvgx', 07:17:44 INFO - 'tsvgr_opacity', 07:17:44 INFO - 'tart', 07:17:44 INFO - 'tscrollx', 07:17:44 INFO - 'cart']}, 07:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:44 INFO - 'tsvgr_opacity', 07:17:44 INFO - 'tart', 07:17:44 INFO - 'tscrollx', 07:17:44 INFO - 'cart']}, 07:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s'], 07:17:44 INFO - 'tests': ['tp5o']}, 07:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'tests': ['tp5o']}, 07:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--disable-e10s', 07:17:44 INFO - '--xperf_path', 07:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:44 INFO - 'tests': ['tp5n']}, 07:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:44 INFO - 'talos_options': ['--xperf_path', 07:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:44 INFO - 'tests': ['tp5n']}}, 07:17:44 INFO - 'talos.zip': {'path': '', 07:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:44 INFO - Running post-action listener: _resource_record_post_action 07:17:44 INFO - ##### 07:17:44 INFO - ##### Finished populate-webroot step (success) 07:17:44 INFO - ##### 07:17:44 INFO - ##### 07:17:44 INFO - ##### Running create-virtualenv step. 07:17:44 INFO - ##### 07:17:44 INFO - Running pre-action listener: _resource_record_pre_action 07:17:44 INFO - Running main action method: create_virtualenv 07:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:44 INFO - Using real prefix '/usr' 07:17:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:47 INFO - Installing pip.................done. 07:17:47 INFO - Return code: 0 07:17:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:47 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:47 INFO - Using env: {'DISPLAY': ':0', 07:17:47 INFO - 'HOME': '/home/cltbld', 07:17:47 INFO - 'LANG': 'en_US.UTF-8', 07:17:47 INFO - 'LANGUAGE': 'en_US:en', 07:17:47 INFO - 'LOGNAME': 'cltbld', 07:17:47 INFO - 'MAIL': '/var/mail/cltbld', 07:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:47 INFO - 'MOZ_NO_REMOTE': '1', 07:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:47 INFO - 'NO_EM_RESTART': '1', 07:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:47 INFO - 'PWD': '/builds/slave/test', 07:17:47 INFO - 'SHELL': '/bin/bash', 07:17:47 INFO - 'SHLVL': '1', 07:17:47 INFO - 'TERM': 'linux', 07:17:47 INFO - 'TMOUT': '86400', 07:17:47 INFO - 'USER': 'cltbld', 07:17:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:47 INFO - '_': '/tools/buildbot/bin/python'} 07:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:47 INFO - Cleaning up... 07:17:47 INFO - Return code: 0 07:17:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:47 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:17:47 INFO - Using env: {'DISPLAY': ':0', 07:17:47 INFO - 'HOME': '/home/cltbld', 07:17:47 INFO - 'LANG': 'en_US.UTF-8', 07:17:47 INFO - 'LANGUAGE': 'en_US:en', 07:17:47 INFO - 'LOGNAME': 'cltbld', 07:17:47 INFO - 'MAIL': '/var/mail/cltbld', 07:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:47 INFO - 'MOZ_NO_REMOTE': '1', 07:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:47 INFO - 'NO_EM_RESTART': '1', 07:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:47 INFO - 'PWD': '/builds/slave/test', 07:17:47 INFO - 'SHELL': '/bin/bash', 07:17:47 INFO - 'SHLVL': '1', 07:17:47 INFO - 'TERM': 'linux', 07:17:47 INFO - 'TMOUT': '86400', 07:17:47 INFO - 'USER': 'cltbld', 07:17:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:47 INFO - '_': '/tools/buildbot/bin/python'} 07:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:47 INFO - Downloading/unpacking psutil>=3.1.1 07:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:49 INFO - Installing collected packages: psutil 07:17:49 INFO - Running setup.py install for psutil 07:17:49 INFO - building 'psutil._psutil_linux' extension 07:17:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:17:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:17:50 INFO - building 'psutil._psutil_posix' extension 07:17:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:17:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:50 INFO - Successfully installed psutil 07:17:50 INFO - Cleaning up... 07:17:50 INFO - Return code: 0 07:17:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:50 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:17:50 INFO - Using env: {'DISPLAY': ':0', 07:17:50 INFO - 'HOME': '/home/cltbld', 07:17:50 INFO - 'LANG': 'en_US.UTF-8', 07:17:50 INFO - 'LANGUAGE': 'en_US:en', 07:17:50 INFO - 'LOGNAME': 'cltbld', 07:17:50 INFO - 'MAIL': '/var/mail/cltbld', 07:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:50 INFO - 'MOZ_NO_REMOTE': '1', 07:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:50 INFO - 'NO_EM_RESTART': '1', 07:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:50 INFO - 'PWD': '/builds/slave/test', 07:17:50 INFO - 'SHELL': '/bin/bash', 07:17:50 INFO - 'SHLVL': '1', 07:17:50 INFO - 'TERM': 'linux', 07:17:50 INFO - 'TMOUT': '86400', 07:17:50 INFO - 'USER': 'cltbld', 07:17:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:50 INFO - '_': '/tools/buildbot/bin/python'} 07:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:52 INFO - Installing collected packages: mozsystemmonitor 07:17:52 INFO - Running setup.py install for mozsystemmonitor 07:17:52 INFO - Successfully installed mozsystemmonitor 07:17:52 INFO - Cleaning up... 07:17:52 INFO - Return code: 0 07:17:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:17:52 INFO - Using env: {'DISPLAY': ':0', 07:17:52 INFO - 'HOME': '/home/cltbld', 07:17:52 INFO - 'LANG': 'en_US.UTF-8', 07:17:52 INFO - 'LANGUAGE': 'en_US:en', 07:17:52 INFO - 'LOGNAME': 'cltbld', 07:17:52 INFO - 'MAIL': '/var/mail/cltbld', 07:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:52 INFO - 'MOZ_NO_REMOTE': '1', 07:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:52 INFO - 'NO_EM_RESTART': '1', 07:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:52 INFO - 'PWD': '/builds/slave/test', 07:17:52 INFO - 'SHELL': '/bin/bash', 07:17:52 INFO - 'SHLVL': '1', 07:17:52 INFO - 'TERM': 'linux', 07:17:52 INFO - 'TMOUT': '86400', 07:17:52 INFO - 'USER': 'cltbld', 07:17:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:52 INFO - '_': '/tools/buildbot/bin/python'} 07:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:55 INFO - warning: no files found matching '*.txt' 07:17:55 INFO - no previously-included directories found matching 'build' 07:17:55 INFO - no previously-included directories found matching 'dist' 07:17:55 INFO - no previously-included directories found matching '.git*' 07:17:55 INFO - Installing collected packages: jsonschema, functools32 07:17:55 INFO - Running setup.py install for functools32 07:17:55 INFO - warning: no files found matching '*.txt' 07:17:55 INFO - no previously-included directories found matching 'build' 07:17:55 INFO - no previously-included directories found matching 'dist' 07:17:55 INFO - no previously-included directories found matching '.git*' 07:17:55 INFO - Successfully installed jsonschema functools32 07:17:55 INFO - Cleaning up... 07:17:55 INFO - Return code: 0 07:17:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:17:55 INFO - Using env: {'DISPLAY': ':0', 07:17:55 INFO - 'HOME': '/home/cltbld', 07:17:55 INFO - 'LANG': 'en_US.UTF-8', 07:17:55 INFO - 'LANGUAGE': 'en_US:en', 07:17:55 INFO - 'LOGNAME': 'cltbld', 07:17:55 INFO - 'MAIL': '/var/mail/cltbld', 07:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:55 INFO - 'MOZ_NO_REMOTE': '1', 07:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:55 INFO - 'NO_EM_RESTART': '1', 07:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:55 INFO - 'PWD': '/builds/slave/test', 07:17:55 INFO - 'SHELL': '/bin/bash', 07:17:55 INFO - 'SHLVL': '1', 07:17:55 INFO - 'TERM': 'linux', 07:17:55 INFO - 'TMOUT': '86400', 07:17:55 INFO - 'USER': 'cltbld', 07:17:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:55 INFO - '_': '/tools/buildbot/bin/python'} 07:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:58 INFO - Downloading docopt-0.6.1.tar.gz 07:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:58 INFO - Running setup.py install for blobuploader 07:17:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:58 INFO - Running setup.py install for requests 07:17:58 INFO - Running setup.py install for docopt 07:17:58 INFO - Successfully installed blobuploader requests docopt 07:17:58 INFO - Cleaning up... 07:17:58 INFO - Return code: 0 07:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:58 INFO - Using env: {'DISPLAY': ':0', 07:17:58 INFO - 'HOME': '/home/cltbld', 07:17:58 INFO - 'LANG': 'en_US.UTF-8', 07:17:58 INFO - 'LANGUAGE': 'en_US:en', 07:17:58 INFO - 'LOGNAME': 'cltbld', 07:17:58 INFO - 'MAIL': '/var/mail/cltbld', 07:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:58 INFO - 'MOZ_NO_REMOTE': '1', 07:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:58 INFO - 'NO_EM_RESTART': '1', 07:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:58 INFO - 'PWD': '/builds/slave/test', 07:17:58 INFO - 'SHELL': '/bin/bash', 07:17:58 INFO - 'SHLVL': '1', 07:17:58 INFO - 'TERM': 'linux', 07:17:58 INFO - 'TMOUT': '86400', 07:17:58 INFO - 'USER': 'cltbld', 07:17:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:58 INFO - '_': '/tools/buildbot/bin/python'} 07:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:58 INFO - Running setup.py (path:/tmp/pip-dKmiki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:59 INFO - Running setup.py (path:/tmp/pip-kHtlYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:59 INFO - Running setup.py (path:/tmp/pip-fqpfO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:59 INFO - Running setup.py (path:/tmp/pip-pEuqV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:59 INFO - Running setup.py (path:/tmp/pip-qHKlGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:59 INFO - Running setup.py (path:/tmp/pip-L3uYn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:59 INFO - Running setup.py (path:/tmp/pip-faMRuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:59 INFO - Running setup.py (path:/tmp/pip-j0x1tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:59 INFO - Running setup.py (path:/tmp/pip-y4LJO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:59 INFO - Running setup.py (path:/tmp/pip-0eVGo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:59 INFO - Running setup.py (path:/tmp/pip-vsBDlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:59 INFO - Running setup.py (path:/tmp/pip-ZDUmgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:59 INFO - Running setup.py (path:/tmp/pip-7mykqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:59 INFO - Running setup.py (path:/tmp/pip-c6M08e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:59 INFO - Running setup.py (path:/tmp/pip-sv7qcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:00 INFO - Running setup.py (path:/tmp/pip-tsvoSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:00 INFO - Running setup.py (path:/tmp/pip-kYw9x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:00 INFO - Running setup.py install for manifestparser 07:18:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozcrash 07:18:00 INFO - Running setup.py install for mozdebug 07:18:00 INFO - Running setup.py install for mozdevice 07:18:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozfile 07:18:00 INFO - Running setup.py install for mozhttpd 07:18:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozinfo 07:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozInstall 07:18:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:00 INFO - Running setup.py install for mozleak 07:18:01 INFO - Running setup.py install for mozlog 07:18:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Running setup.py install for moznetwork 07:18:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Running setup.py install for mozprocess 07:18:01 INFO - Running setup.py install for mozprofile 07:18:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Running setup.py install for mozrunner 07:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Running setup.py install for mozscreenshot 07:18:01 INFO - Running setup.py install for moztest 07:18:01 INFO - Running setup.py install for mozversion 07:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:01 INFO - Cleaning up... 07:18:01 INFO - Return code: 0 07:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:01 INFO - Using env: {'DISPLAY': ':0', 07:18:01 INFO - 'HOME': '/home/cltbld', 07:18:01 INFO - 'LANG': 'en_US.UTF-8', 07:18:01 INFO - 'LANGUAGE': 'en_US:en', 07:18:01 INFO - 'LOGNAME': 'cltbld', 07:18:01 INFO - 'MAIL': '/var/mail/cltbld', 07:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:01 INFO - 'MOZ_NO_REMOTE': '1', 07:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:01 INFO - 'NO_EM_RESTART': '1', 07:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:01 INFO - 'PWD': '/builds/slave/test', 07:18:01 INFO - 'SHELL': '/bin/bash', 07:18:01 INFO - 'SHLVL': '1', 07:18:01 INFO - 'TERM': 'linux', 07:18:01 INFO - 'TMOUT': '86400', 07:18:01 INFO - 'USER': 'cltbld', 07:18:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:01 INFO - '_': '/tools/buildbot/bin/python'} 07:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:02 INFO - Running setup.py (path:/tmp/pip-BVArUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:02 INFO - Running setup.py (path:/tmp/pip-dOrGmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:02 INFO - Running setup.py (path:/tmp/pip-vImGJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:02 INFO - Running setup.py (path:/tmp/pip-wHA1ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:02 INFO - Running setup.py (path:/tmp/pip-dzGn2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:02 INFO - Running setup.py (path:/tmp/pip-ERF1AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:02 INFO - Running setup.py (path:/tmp/pip-lz0_bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:02 INFO - Running setup.py (path:/tmp/pip-HQX6LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:02 INFO - Running setup.py (path:/tmp/pip-TTKygt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:02 INFO - Running setup.py (path:/tmp/pip-zyTjZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:02 INFO - Running setup.py (path:/tmp/pip-iH5wkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:03 INFO - Running setup.py (path:/tmp/pip-JAZZgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:03 INFO - Running setup.py (path:/tmp/pip-CSDzMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:03 INFO - Running setup.py (path:/tmp/pip-_cjtsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:03 INFO - Running setup.py (path:/tmp/pip-fMIt9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:03 INFO - Running setup.py (path:/tmp/pip-IKZIhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:03 INFO - Running setup.py (path:/tmp/pip-gdVq2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - Downloading blessings-1.6.tar.gz 07:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:05 INFO - Installing collected packages: blessings 07:18:05 INFO - Running setup.py install for blessings 07:18:05 INFO - Successfully installed blessings 07:18:05 INFO - Cleaning up... 07:18:05 INFO - Return code: 0 07:18:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:05 INFO - Reading from file tmpfile_stdout 07:18:05 INFO - Current package versions: 07:18:05 INFO - argparse == 1.2.1 07:18:05 INFO - blessings == 1.6 07:18:05 INFO - blobuploader == 1.2.4 07:18:05 INFO - docopt == 0.6.1 07:18:05 INFO - functools32 == 3.2.3-2 07:18:05 INFO - jsonschema == 2.5.1 07:18:05 INFO - manifestparser == 1.1 07:18:05 INFO - mozInstall == 1.12 07:18:05 INFO - mozcrash == 0.17 07:18:05 INFO - mozdebug == 0.1 07:18:05 INFO - mozdevice == 0.48 07:18:05 INFO - mozfile == 1.2 07:18:05 INFO - mozhttpd == 0.7 07:18:05 INFO - mozinfo == 0.9 07:18:05 INFO - mozleak == 0.1 07:18:05 INFO - mozlog == 3.2 07:18:05 INFO - moznetwork == 0.27 07:18:05 INFO - mozprocess == 0.22 07:18:05 INFO - mozprofile == 0.28 07:18:05 INFO - mozrunner == 6.11 07:18:05 INFO - mozscreenshot == 0.1 07:18:05 INFO - mozsystemmonitor == 0.3 07:18:05 INFO - moztest == 0.7 07:18:05 INFO - mozversion == 1.4 07:18:05 INFO - psutil == 3.1.1 07:18:05 INFO - requests == 1.2.3 07:18:05 INFO - wsgiref == 0.1.2 07:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:05 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:05 INFO - Using env: {'DISPLAY': ':0', 07:18:05 INFO - 'HOME': '/home/cltbld', 07:18:05 INFO - 'LANG': 'en_US.UTF-8', 07:18:05 INFO - 'LANGUAGE': 'en_US:en', 07:18:05 INFO - 'LOGNAME': 'cltbld', 07:18:05 INFO - 'MAIL': '/var/mail/cltbld', 07:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:05 INFO - 'MOZ_NO_REMOTE': '1', 07:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:05 INFO - 'NO_EM_RESTART': '1', 07:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:05 INFO - 'PWD': '/builds/slave/test', 07:18:05 INFO - 'SHELL': '/bin/bash', 07:18:05 INFO - 'SHLVL': '1', 07:18:05 INFO - 'TERM': 'linux', 07:18:05 INFO - 'TMOUT': '86400', 07:18:05 INFO - 'USER': 'cltbld', 07:18:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:05 INFO - '_': '/tools/buildbot/bin/python'} 07:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:06 INFO - Cleaning up... 07:18:06 INFO - Return code: 0 07:18:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:06 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 0x2376030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, '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': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:18:06 INFO - Using env: {'DISPLAY': ':0', 07:18:06 INFO - 'HOME': '/home/cltbld', 07:18:06 INFO - 'LANG': 'en_US.UTF-8', 07:18:06 INFO - 'LANGUAGE': 'en_US:en', 07:18:06 INFO - 'LOGNAME': 'cltbld', 07:18:06 INFO - 'MAIL': '/var/mail/cltbld', 07:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:06 INFO - 'MOZ_NO_REMOTE': '1', 07:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:06 INFO - 'NO_EM_RESTART': '1', 07:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:06 INFO - 'PWD': '/builds/slave/test', 07:18:06 INFO - 'SHELL': '/bin/bash', 07:18:06 INFO - 'SHLVL': '1', 07:18:06 INFO - 'TERM': 'linux', 07:18:06 INFO - 'TMOUT': '86400', 07:18:06 INFO - 'USER': 'cltbld', 07:18:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:06 INFO - '_': '/tools/buildbot/bin/python'} 07:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:18:06 INFO - Cleaning up... 07:18:06 INFO - Return code: 0 07:18:06 INFO - Running post-action listener: _resource_record_post_action 07:18:06 INFO - Running post-action listener: _start_resource_monitoring 07:18:06 INFO - Starting resource monitoring. 07:18:06 INFO - ##### 07:18:06 INFO - ##### Finished create-virtualenv step (success) 07:18:06 INFO - ##### 07:18:06 INFO - ##### 07:18:06 INFO - ##### Running install step. 07:18:06 INFO - ##### 07:18:06 INFO - Running pre-action listener: _resource_record_pre_action 07:18:06 INFO - Running main action method: install 07:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:06 INFO - Reading from file tmpfile_stdout 07:18:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:18:06 INFO - Reading from file tmpfile_stdout 07:18:06 INFO - Output received: 07:18:06 INFO - Usage: mozinstall [options] installer 07:18:06 INFO - Options: 07:18:06 INFO - -h, --help show this help message and exit 07:18:06 INFO - -d DEST, --destination=DEST 07:18:06 INFO - Directory to install application into. [default: 07:18:06 INFO - "/builds/slave/test"] 07:18:06 INFO - --app=APP Application being installed. [default: firefox] 07:18:06 INFO - mkdir: /builds/slave/test/build/application 07:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:18:23 INFO - Reading from file tmpfile_stdout 07:18:23 INFO - Output received: 07:18:23 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:23 INFO - Running post-action listener: _resource_record_post_action 07:18:23 INFO - ##### 07:18:23 INFO - ##### Finished install step (success) 07:18:23 INFO - ##### 07:18:23 INFO - ##### 07:18:23 INFO - ##### Running run-tests step. 07:18:23 INFO - ##### 07:18:23 INFO - Running pre-action listener: _resource_record_pre_action 07:18:23 INFO - Running main action method: run_tests 07:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:23 INFO - Python 2.7.3 07:18:23 INFO - Return code: 0 07:18:23 INFO - grabbing minidump binary from tooltool 07:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:23 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 0x26353b0>, '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 0x26362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2636740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:18:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:18:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:18:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:23 INFO - Return code: 0 07:18:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 07:18:23 INFO - Using env: {'DISPLAY': ':0', 07:18:23 INFO - 'HOME': '/home/cltbld', 07:18:23 INFO - 'LANG': 'en_US.UTF-8', 07:18:23 INFO - 'LANGUAGE': 'en_US:en', 07:18:23 INFO - 'LOGNAME': 'cltbld', 07:18:23 INFO - 'MAIL': '/var/mail/cltbld', 07:18:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:23 INFO - 'MOZ_NO_REMOTE': '1', 07:18:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:23 INFO - 'NO_EM_RESTART': '1', 07:18:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:23 INFO - 'PWD': '/builds/slave/test', 07:18:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:23 INFO - 'SHELL': '/bin/bash', 07:18:23 INFO - 'SHLVL': '1', 07:18:23 INFO - 'TERM': 'linux', 07:18:23 INFO - 'TMOUT': '86400', 07:18:23 INFO - 'USER': 'cltbld', 07:18:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142', 07:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:23 INFO - '_': '/tools/buildbot/bin/python'} 07:18:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:18:24 INFO - mozversion application_buildid: 20160701043016 07:18:24 INFO - mozversion application_changeset: f531396cd66b517efa632d0d61db3b6a569ba6ae 07:18:24 INFO - mozversion application_display_name: Nightly 07:18:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:24 INFO - mozversion application_name: Firefox 07:18:24 INFO - mozversion application_remotingname: firefox 07:18:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:24 INFO - mozversion application_vendor: Mozilla 07:18:24 INFO - mozversion application_version: 50.0a1 07:18:24 INFO - mozversion platform_buildid: 20160701043016 07:18:24 INFO - mozversion platform_changeset: f531396cd66b517efa632d0d61db3b6a569ba6ae 07:18:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:24 INFO - mozversion platform_version: 50.0a1 07:18:24 INFO - using testdate: 1467382704 07:18:24 INFO - actual date: 1467382704 07:18:24 INFO - starting webserver on 'localhost:60843' 07:18:24 INFO - SUITE-START | Running 2 tests 07:18:24 INFO - TEST-START | dromaeo_css 07:18:24 INFO - operating with platform_type : linux_ 07:18:24 INFO - Initialising browser for dromaeo_css test... 07:18:24 INFO - TEST-INFO | started process 11702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0URYVf/profile http://localhost:60843/getInfo.html) 07:18:27 INFO - PROCESS | 11702 | __metrics Screen width/height:1600/1200 07:18:27 INFO - PROCESS | 11702 | colorDepth:24 07:18:27 INFO - PROCESS | 11702 | Browser inner width/height: 1024/697 07:18:27 INFO - PROCESS | 11702 | __metrics 07:18:28 INFO - PROCESS | 11702 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:29 INFO - TEST-INFO | 11702: exit 0 07:18:29 INFO - Browser initialized. 07:18:29 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:29 INFO - TEST-INFO | started process 11784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0URYVf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:41 INFO - PROCESS | 11784 | RSS: Main: 157184000 07:18:41 INFO - PROCESS | 11784 | 07:19:32 INFO - PROCESS | 11784 | 1467382772961 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:21:40 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60843/tests/dromaeo/cssquery-ext.html) 07:21:41 INFO - PROCESS | 11784 | RSS: Main: 291745792 07:21:41 INFO - PROCESS | 11784 | 07:24:44 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-ext.html (next: http://localhost:60843/tests/dromaeo/cssquery-jquery.html) 07:24:44 INFO - PROCESS | 11784 | RSS: Main: 244518912 07:24:44 INFO - PROCESS | 11784 | 07:27:46 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60843/tests/dromaeo/cssquery-mootools.html) 07:27:47 INFO - PROCESS | 11784 | RSS: Main: 245002240 07:27:47 INFO - PROCESS | 11784 | 07:30:49 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60843/tests/dromaeo/cssquery-prototype.html) 07:30:50 INFO - PROCESS | 11784 | RSS: Main: 243236864 07:30:50 INFO - PROCESS | 11784 | 07:33:52 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60843/tests/dromaeo/cssquery-yui.html) 07:33:53 INFO - PROCESS | 11784 | RSS: Main: 206643200 07:33:53 INFO - PROCESS | 11784 | 07:36:55 INFO - PROCESS | 11784 | Cycle 1(1): loaded http://localhost:60843/tests/dromaeo/cssquery-yui.html (next: http://localhost:60843/tests/dromaeo/cssquery-dojo.html) 07:36:56 INFO - PROCESS | 11784 | RSS: Main: 290893824 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | __start_tp_report 07:36:56 INFO - PROCESS | 11784 | _x_x_mozilla_page_load 07:36:56 INFO - PROCESS | 11784 | _x_x_mozilla_page_load_details 07:36:56 INFO - PROCESS | 11784 | |i|pagename|runs| 07:36:56 INFO - PROCESS | 11784 | |0;dojo.html;3074.9385012299754;3092.7061929116726;3107.0523490335445;3121.6410112837;3148.5434611981264;5069.695818250908;5141.383034035921;5271.393789714184;5331.653442526238;5353.678779273241;5172.069027575044;5243.213517972306;5248.448912864152;5305.549028332587;5314.202869569566;4763.61891048717;4855.126077306083;4865.367502224706;4869.123557759602;5011.949880501203;4930.679505832128;4986.252062190664;4988.825391111312;4991.850244492653;5008.9499105008845;4774.904501909959;4802.399700037513;4818.927716084261;4830.323754674313;4857.854264372057;4794.113089078532;4805.735684537349;4807.375041244616;4880.267959806022;4921.557059864629;4807.951920480786;4831.830885918976;4843.733594652293;4868.245421959602;4891.437484689271;5119.411267704225;5206.557442617382;5326.280952071498;5367.892642147135;5393.83818485446;5792.391798861101;5804.448577385142;5824.679642619654;5826;5827.825165245049;5845.941540584582;5846.941530584725;5887.322957859858;5895.233619629464;5897.292324920994;5150.072986862363;5182.455842136559;5196.8960620787375;5217;5474.206240095204;5766.509846663081;5770.913436298459;5775.249217601769;5781.132830075522;5781.566382521243;5517.751701173457;5525.585581081355;5560.304961879765;5564.777408903598;5570.749316280777;5480.588955828249;5551.444855514497;5585.469380408855;5591.552675785927;5634.352049514277;5552.583556233299;5606.411326810708;5607.719614019283;5614.6631202128;5615.943840561624;5540.833774986757;5558.555315574744;5558.72206389687;5562.749676264497;5608.439156084359;4242.44848169736;4254.829806807693;4260.616544510947;4271.914561708749;4296.441462609903;3820.980895095562;3839.5584507781405;3840.9039774005873;3859.7877116758846;3862.6909847212155;5225.320708307896;5257.684538927677;5305.708186049727;5311.49540793624;5366;5632.127020311858;5654.547636189095;5709.400512946081;5714.200011998323;5744.655320680772;5399.649022813504;5402;5407.459254074561;5409.594280428905;5411.648242864201;4805.3512775774825;4847.127517046895;4944.220707782225;4950.158473059589;5003.3495645565845;5744.253247077853;5812.796552120655;5813.5349172066135;5815.73829177688;5880.088586269135;5634;5648.604597678123;5649.491545760737;5650.124230744241;5663.773449061991;5663.66018038919;5782.10377391505;5798.82603521895;5896.439838215363;5960.821175364746;5648.350439699487;5654.208410822406;5661.320641523043;5670.943290567042;5714.399988001366;5725.599208055396;5743.0811070228565;5752.367239603724;5756.165356023437;5773.364929857797;5450.155225939986;5524.116141417515;5537.8061767837935;5595.664260144405;5603.131514615241;5583.972080139573;5586.972065139648;5591.4688104629995;5591.608587398843;5592.860178495407;5462.235287059735;5464.1257398816;5491.395946445968;5512.80705175317;5554.555635549227;5421.674699518042;5421.83734487966;5429.484199001088;5467.4532546745;5473.863153421196;5339.225812257278;5359.839204823861;5369.382521010134;5369.48989845964;5370.436104209158 07:36:56 INFO - PROCESS | 11784 | |1;ext.html;581.9738111784969;617.1175219436205;620.3672254300614;636.7453018792486;638.9872052796318;42798.35802462962;43974.780126099366;44020.3396949046;44106.338404923954;47082.529174708245;45346.093078138416;45727.31409028867;45797.31304030442;45801.541984580144;45835.31247031297;8958.955205223965;9029.729108126734;9097.63609455621;9101.271898248157;9109.544522773835;8940.06129356418;8998.415103018282;9010.27917766577;9027.14242146995;9037.41256818308;9090.63637454501;9125.634974601042;9130.406523575979;9132.178103970642;9139.908600913972;9000.414973026733;9008.59461324242;9039.548022598876;9044.688520164606;9067.229285510739;8855.911440885573;8907.242884354837;8926.509042002688;8928.687495937676;8929.955350223272;43085.78457107695;43404;43582.564174358165;43594.78202608998;43599;3551.5383000210068;3650.7444478886487;3658.8353524091212;3898.610138986107;4206.72656277341;32574.348513029843;32869.17827054343;33146;33184.17039574006;34097.56731624873;3649.8905032849057;3877.9806100969595;3931.331673615492;3955.4857868476915;3979.900502487432;319531;319790;320367;320870;321005;51640.48359516432;58473;58680.70659646674;58989.70505147533;59071.40928590659;61416;61466;61466.69266653638;61561;61578;13557.186568805902;13564.321783910962;13586.592402227949;13701.520446784514;13780.93109534466;10470.424126673106;10640.095591874622;10648.094911932418;10650.520726567323;10654.094401975764;15218.239088045553;16744.748828767577;16763.91618041902;16806.747898781527;16879.662406752042;5612.550995920316;5621.353544342453;5681.829545113653;5689.459501347365;5737.340205876294;947.2185447006248;1025.9076683098558;1061.124572227915;1119.7243755383213;1179.8761130081389;32233.67766322307;32281.192970175933;32631.4789918484;32748.181295467326;33236.83381583125;1075.5536452372335;1077.9813076642497;1081.751197224627;1112.6161474291357;1210.4250481021445;16570;17224.569385765455;17261.741073883903;17332.91333543324;17609.911950440164;536774;538560;542814;544008;545400;57224.42775572191;57295.713521432124;57453.42546574564;57690;57789.71105144447;1235.1415766042694;1323.7815760399426;1362.1963041805382;1374.1892283552552;1375.408574313055;32465.837670811496;33345.33309333751;33666.49500257547;33759;33805.32389352249;49547.50452495573;49703.25445118399;50039.24941125813;50088;50101;306337;306374;307885;308537;308710;34996.825015874754;40533.59466405298;41283.587164129174;41434.171316572894;41466.792666036476;46908.53091469178;47435.52564474311;47541;48421.757891211724;48432;39757.885627319025;40352;41079.794601028;41411.1717765649;41649.79175104105;40270.1945961085;40513.39229911612;41629.37555936724;42078.36882446827;42218.36672449977;40099.39850902297;40122.79938600288;40474.19051618892;41092;41331;35193.29613407666;35982.64017359793;36812.447813282284;37157.81421092877;37246.255074898894;27787.30531736642;27811.165665030083;28041.57937630978;28096;28133.859330703217 07:36:56 INFO - PROCESS | 11784 | |2;jquery.html;391.44805823788454;397.99602003979953;410.71455338539727;412.2702816015652;420.8274607410962;14059.5079172229;18812.717809232872;20417.897910510444;20463.079161437752;20631.896840515816;16104.919475402636;19336.226550937947;20207.898960505212;20250.29123980661;20792.272270470537;5658.179563963233;5839.737211825478;5851.093080572518;5866.413358664142;5866.442687944638;5562.582806289524;5760.683162426065;5783.219265399181;5839.240898683165;5845.5908086433965;5702.3157221133315;5715.028445164311;5757.107648314518;5759.913601295984;5764.048931926227;5532.1425179097505;5699.344575373843;5713.400092990239;5720.971395142998;5734.4265573442735;5155.355580552431;5163.8192663256605;5167.48325167484;5184.792608295701;5191.273221748958;23196.53606927852;24768.628470572956;24831.62752558713;25638.615420768703;25659;2332.720073591163;2422.878856057208;2423.0550085466684;2633.210036988915;2680.222735406749;14016.85983140176;14036.789448158286;14446.783298250535;14698.926505367512;15078.773818392732;1898.6582415165265;1930.8165724256173;1982.930597429083;2026.311054241565;2053.722747429093;84871.57564212201;85574.14425855724;87050.5647471765;87319.56340218322;88325.99999999936;9199.356045076915;9664.130228279488;9839.409635421755;10279.897201028043;10505.474726263656;14318.785218221736;14333;14367.28163591837;14464.710705785825;14472.565823025116;7268.45486588508;7388.519746216479;7609.315161635479;7634;7659.119201291923;6600.636964966973;7096.325849044332;7152.249013853574;7244.275572442713;7440.218777028443;4760.523947605212;4951.554360107608;5083.567896728746;5100.0364859529345;5156.819511317086;1977.8714383565023;1984.5237143085556;2048.09883651193;2109.1563374650264;2110.3457928042358;905.7509184974053;947.2564037230741;1043.2019505078622;1059.7721489879714;1076.7200527862813;19196.71204931927;19876.50308742293;20529.384118476468;20872.06075726596;20960.798544485613;950.5864948747317;983.6360546597662;989.302541708094;996.9651062212788;1040.2614143957874;10934.835977460345;11358.432078396047;11479.827802582968;11481.253718508271;11514;444444;445162;450608;461331;461659;96113.51943240239;102376.48811755894;102481;102901;104423;1061.1828891753307;1062.1821197677746;1083.8482612434266;1096.873859506167;1109.4120116338354;18200.72698909491;18692.25230990745;18710.625787483903;18711;18878.24487020504;43124.78437607917;44177;44357.556424435345;44388.77805610951;45994;62666.373336267876;62789.37210628018;63519.6824015877;63890.68054659697;64511;8739.956300218459;9151.816963660556;9230.307726920642;9286.489243091424;9377.531123443938;13970.797312195487;14239.288035597972;14653.706925861636;14714.337854796346;14894.702105958037;12371.566995155126;12599.87400125987;12799.872001279868;12815.462144542715;12840.871591283967;12452.190607610477;12498.500059997861;12594.559190428292;12683.365831708194;12714.936425317814;12488.937555312528;12686.619401417973;12827;12860.549880754128;12919.935400322938;8905.51019693923;9087.59105840252;9325.440473571607;9400.435973841591;9442.669506567237;10209.642662506776;12709.364531773559;12765.170263932814;12772.87227127754;12774.105812593029 07:36:56 INFO - PROCESS | 11784 | |3;mootools.html;1313.6650154210674;1456.5047883719533;1494.8804095672347;1597.337105101383;1768.1601239411282;8274.958625206873;8675.045744968056;8688.522131282769;8919.331050171231;8939.329550283723;8658.696945606906;8827.33794965377;8836.779080522974;8839.823203535925;8867.955660221689;2076.3148161106797;2139.5613899150635;2140.9892950535227;2322.8606283622994;2355.8704271265074;2318.9536209275802;2411.6623672685837;2415.420299128214;2417.576924038295;2422.527607116613;2310.5609934112463;2378.4886249456363;2386.9283921482383;2393;2402.135231316733;2029.3810387831707;2294.3346429535413;2299.1033496936207;2300.87345196015;2319.1998760427628;2381.7975472084895;2414.553307638075;2418.238254949685;2418.600930846408;2419.4193393585415;8711.869321960112;8737.563121843883;8783;8803.911960880374;8806.20744133031;5232.162853943389;5380.488853558905;5387.919181212285;5395.676259424447;5397.217403476513;3213.2770126721534;3337.8998630041137;3443.810590417526;3456.3260164267977;3467.8959631211105;1063.4310643805604;1064.0317311246806;1080.6649938519006;1087.0488322717622;1098.4672433869566;12322.137450378477;12391.690207744788;12428.813567796491;12445.439955202037;12519.248845069234;4663.51033141522;4678.157931572282;4843.128236917389;4887.780049897763;4894.657373983858;10525.89474105249;10547.947260263803;10554.313969592105;10573.682789516326;10621.150307975498;5418.83743487696;5431.701256430934;5435.320584926884;5449.3460784706085;5449.455054494598;4200.3699445082875;4365.454318210223;4498.640108791289;4688.109259240733;4990.326305948723;4179.477565304337;4201.936970945439;4209.621134097946;4245.5542168072525;4304.526502084768;1252.7056141806668;1324.569514907659;1331.1680199875077;1334.3395019465427;1354.525915929417;823.6869989404108;939.3753154152548;941.8304705153001;948.2035090523993;957.8084383123403;5843.29880414353;5886.117082437583;5899.262592175978;5998.430149135826;6047.455728984412;456.78074524228555;470.3274317725685;479.549223729693;480.28677414040123;996.6611352140308;4087.713860029829;4193.832246710159;4197.496300443966;4220.07158425146;4226.661867050629;10886.67339979802;11222.55109795599;11307.208495405243;11307.717307067389;11322.094232461382;10572.101371383365;10943.179261555415;11028;11192.944035279934;11206.607768728056;8225.341972642174;8422.494650321001;8537.74386768398;8602.913970860336;8614.26778723803;5942.1978032965;5953.910691339547;5961.701914904324;6034.577579569564;6061.090836374579;10250.641227557298;10474.842877356998;10480.266381353233;10503.737406564896;10514.842277365999;9591.136797688241;10177.18582513412;10610.575576976835;10887.074598659203;10888.40113793749;7961.9203807963495;8071.152528984372;8091.797705057185;8304.211099945496;8307.543085130375;8029.5583742894705;8162.510249385056;8210.958945205475;8227.876581851397;8261.091279959079;7573.2048134947245;7687.154413014676;7708.922910771045;7788.571628560484;7849.921500785147;7575.318221360104;7681.539107653559;7696;7779.222077792176;7823.295903368724;6798.830029249309;7022.473314501331;7078.823029424306;7088.964555177191;7089.042979197949;4946.35697359341;5039.874003149804;5048.116579598629;5058.898822023465;5076.086304465084;5041.899162016666;5117.795288188431;5201.141811601044;5265.394479634738;5303.602229832701 07:36:56 INFO - PROCESS | 11784 | |4;prototype.html;319.4393838812883;327.1787812590398;333.78971248113686;335.90762540301404;336.1763678986484;5155.71643559604;5187.377514698242;5352.892942141159;5379.488948549892;5381.192821076836;5295.708736019517;5308.150695888658;5314.495122963322;5326.467353264671;5360.3299587551555;4228.957710422903;4248;4255.319148936171;4261;4276.486821581415;3946.3488524393442;3993.480847489837;4173.227952828721;4232.936505952413;4237.872863814075;4152.356384760352;4162.625363717265;4166.729162604436;4168.583141685823;4171.520275168349;4117.423560701504;4150.92076060225;4153.273177193994;4155.148194620126;4190.51809041961;3487.8256087195537;3698.5760482214273;3724.4599533067826;3726.950177402418;3733.383991641376;5186.507281808223;5211.0359583477175;5219.530242278175;5225.790968361261;5238.795077132243;4728.858134255978;4732.952670473285;4733.148033353995;4740.549647783455;4742.861713188844;5435.755391007414;5498.505134537871;5574.470425309589;5582.845692183903;5586.329640443173;3910.9608903911167;3929.6659783918403;3930.64624183822;3931.312020396419;3942.1327307992483;5747.885042299173;5750.7987220447085;5756.539476841885;5764.16419619157;5775.624584402;3924.843006279717;4064.634182923551;4072.554243243606;4073.572274911151;4073.816678249427;4110.876673699734;4111.9177616447505;4116.855910043134;4122.40225167349;4123.824709957647;4684.4378674559275;4706.529347065266;4720.221163508051;4720.291956206528;4723.574878260973;5477.835664930059;5604.41153678866;5614.382417934024;5630.943690563042;5654.9151762723595;1401.3833913078213;1414.978775318371;1417.5676418692399;1425.8217722784652;1427.7572812621672;874.2350443362059;896.0054339682947;911.910267230653;912.7672443526991;916.7616419730784;4792.592629626521;4814.20565606678;4823.662343635982;4827.951720482821;4842.273658951185;5038.924416133761;5053.46938571452;5072.163093089673;5078.974605127025;5082.237664350377;4628.552890973986;4812.783424745895;4819.614430845524;4836.153673107192;4842.394700662418;2638.2349118755346;2659.3617531792615;2692.9730702693114;2707.9593806092926;2716.388812517168;5169.508896654812;5170.302009228782;5170.405403378584;5171.32772739549;5172.482751724798;4984.283565456834;5060.886604946906;5172.353455818023;5180.326557547494;5202.271681964528;5115.820946266863;5195.818146364859;5198.194279886624;5205;5211.644972307227;5030.924536131888;5045.217991211368;5080.314157588678;5082.669626474268;5118.513741194581;4965.354503914613;5001.42483614389;5317.308749862493;5797.246308003833;5801.274840644919;5917.260342457193;5941.762329506944;5958.880822383615;5973.49225315853;5998.040313549811;3912.5696173420333;4074.5721699221153;4085.5301640311745;4186.455760751083;4202.27706640276;5670.206171135962;5703.490464195741;5725.713714314351;5744.741486633196;5754.6547207167705;5583.916241256303;5595.580331475075;5600.327960644749;5606.635568688022;5637.126245431965;5328.733563321741;5627.409122042127;5662.688552129508;5664.357336372406;5664.433556644467;5528.917066243929;5554.972225138848;5566.471185237558;5583.916241256303;5596.272484576979;5331.440198779227;5590.664560126405;5655.151727240782;5665.263515742927;5685.943140568541;5452.182172674131;5483.643563168382;5487.862803429946;5491.341039075336;5495.917561236504 07:36:56 INFO - PROCESS | 11784 | |5;yui.html;701.8140192848895;753.1564647594695;769.8883661869029;800.3677095094876;824.4146655874329;14986.700265994674;15654.765178522317;15888.285027173775;16197.757033644475;16267.593310167253;15130.773038404433;15316.234188290597;15349.155796431192;15378.923475356729;15483.458078967238;668.4919461209491;795.5107608820563;803.4777394693452;820.0774129104757;823.7569916874506;811.5171472973601;813.1421350475247;815;815.042325267811;816.0452270843127;864.5504337744369;864.8486514859906;865.3034307382554;865.4763867859948;866.6360128745911;687.0724521895451;826.7891687619649;844.9915500844975;845.2308399356587;856.0968178571604;625.0561651905609;626.1734510446213;626.3955283151735;627.0030651264466;627.3600927054379;15429.459968901147;15449.845501544953;15453.845461545354;15469.149196794171;15532.844671553254;14405.92797036008;14529.709405811824;14565.344559494848;14731.337089830984;14921.179335136563;12239.265644061385;12617;13061.673458163621;13088.79324565478;13413;3758.1168425420005;3790.5261842269715;3794.810259487042;3807.847686092553;3891.1439483313625;77171.22828771696;78257.60871195665;78263.6086819568;78808;79750.60124699397;9627.422354658744;9746.561404736804;9823.803523929482;9884.357516761387;10013.449260290608;18876.150573224237;18922.432327030212;18930.810691892904;19012.524686882938;19143.2342706293;7658.73194438192;7947.602619868983;8127.878081828777;8538.44500107491;8715.825683486295;4699.483056863743;4753.9762301188275;4812.422509298836;4932.26016097581;4967.925481117786;3359.160209947513;3462.0479368173956;3472.357613841397;3477.1654802847133;3479.7390195734915;592.63552914957;593.2258402784322;597.2146627185238;609.713434685697;649.7985624456434;514.6448950224408;521.7756364763112;555.8221369161829;584.4593750780512;637.445422482434;9207.953960230156;9521.381110227952;9947.768989702943;10073.748156296151;10091;634.8444631065327;656.6322859198864;659.953803233769;661.503872095928;668.4585485756455;3869.613038696164;3898.5516665583255;3908.257431088084;4015.5382131054716;4044.8786536403954;82281;126329;128120.35939820242;129325;130337;111691.44154279177;112989;113467.4326628378;114800;118071.40964295123;93441.53279233561;93755;94417;95057.39398919267;99375;7268.563886166847;7315.6342182889575;7399.297066778648;7520.774376768706;7601.695932162652;54266;56519;56569;57528.424715752306;58231.70884145552;78543.60728196322;83389;84045.57977210075;86126;86249.13750862662;11424.314541127558;11630.127740419672;11695.064394848221;11969.102317326062;12074.45664945097;13308.667283317607;13363.53227637028;13381.732365352833;13844.584662460142;14068;11737.530498779954;12431.875681243071;12687.11190216676;12845.486180552673;12881.871181288067;12189.451474683483;12506.749865002466;12589.748205035665;12666.430010649727;12910.67723306925;11837.348945807718;11863.703407414883;12107.091968102604;12336;12349.691257718629;9445.527723613654;9720.708378748648;9763.78422444489;9987.500624968578;10084.142847858015;9420.858687119562;9518.95240523793;9598.808023839345;9688.951555242178;10110.241731869992 07:36:56 INFO - PROCESS | 11784 | __end_tp_report 07:36:56 INFO - PROCESS | 11784 | __start_cc_report 07:36:56 INFO - PROCESS | 11784 | _x_x_mozilla_cycle_collect,1110 07:36:56 INFO - PROCESS | 11784 | __end_cc_report 07:36:56 INFO - PROCESS | 11784 | __startTimestamp1467383816217__endTimestamp 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | ------- Summary: start ------- 07:36:56 INFO - PROCESS | 11784 | Number of tests: 6 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#0] dojo.html Cycles:165 Average:5266.08 Median:5450.16 stddev:594.89 (10.9%) stddev-sans-first:571.35 07:36:56 INFO - PROCESS | 11784 | Values: 3074.9 3092.7 3107.1 3121.6 3148.5 5069.7 5141.4 5271.4 5331.7 5353.7 5172.1 5243.2 5248.4 5305.5 5314.2 4763.6 4855.1 4865.4 4869.1 5011.9 4930.7 4986.3 4988.8 4991.9 5008.9 4774.9 4802.4 4818.9 4830.3 4857.9 4794.1 4805.7 4807.4 4880.3 4921.6 4808.0 4831.8 4843.7 4868.2 4891.4 5119.4 5206.6 5326.3 5367.9 5393.8 5792.4 5804.4 5824.7 5826.0 5827.8 5845.9 5846.9 5887.3 5895.2 5897.3 5150.1 5182.5 5196.9 5217.0 5474.2 5766.5 5770.9 5775.2 5781.1 5781.6 5517.8 5525.6 5560.3 5564.8 5570.7 5480.6 5551.4 5585.5 5591.6 5634.4 5552.6 5606.4 5607.7 5614.7 5615.9 5540.8 5558.6 5558.7 5562.7 5608.4 4242.4 4254.8 4260.6 4271.9 4296.4 3821.0 3839.6 3840.9 3859.8 3862.7 5225.3 5257.7 5305.7 5311.5 5366.0 5632.1 5654.5 5709.4 5714.2 5744.7 5399.6 5402.0 5407.5 5409.6 5411.6 4805.4 4847.1 4944.2 4950.2 5003.3 5744.3 5812.8 5813.5 5815.7 5880.1 5634.0 5648.6 5649.5 5650.1 5663.8 5663.7 5782.1 5798.8 5896.4 5960.8 5648.4 5654.2 5661.3 5670.9 5714.4 5725.6 5743.1 5752.4 5756.2 5773.4 5450.2 5524.1 5537.8 5595.7 5603.1 5584.0 5587.0 5591.5 5591.6 5592.9 5462.2 5464.1 5491.4 5512.8 5554.6 5421.7 5421.8 5429.5 5467.5 5473.9 5339.2 5359.8 5369.4 5369.5 5370.4 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#1] ext.html Cycles:180 Average:56219.44 Median:41371.09 stddev:107164.63 (259.0%) stddev-sans-first:107383.84 07:36:56 INFO - PROCESS | 11784 | Values: 582.0 617.1 620.4 636.7 639.0 42798.4 43974.8 44020.3 44106.3 47082.5 45346.1 45727.3 45797.3 45801.5 45835.3 8959.0 9029.7 9097.6 9101.3 9109.5 8940.1 8998.4 9010.3 9027.1 9037.4 9090.6 9125.6 9130.4 9132.2 9139.9 9000.4 9008.6 9039.5 9044.7 9067.2 8855.9 8907.2 8926.5 8928.7 8930.0 43085.8 43404.0 43582.6 43594.8 43599.0 3551.5 3650.7 3658.8 3898.6 4206.7 32574.3 32869.2 33146.0 33184.2 34097.6 3649.9 3878.0 3931.3 3955.5 3979.9 319531.0 319790.0 320367.0 320870.0 321005.0 51640.5 58473.0 58680.7 58989.7 59071.4 61416.0 61466.0 61466.7 61561.0 61578.0 13557.2 13564.3 13586.6 13701.5 13780.9 10470.4 10640.1 10648.1 10650.5 10654.1 15218.2 16744.7 16763.9 16806.7 16879.7 5612.6 5621.4 5681.8 5689.5 5737.3 947.2 1025.9 1061.1 1119.7 1179.9 32233.7 32281.2 32631.5 32748.2 33236.8 1075.6 1078.0 1081.8 1112.6 1210.4 16570.0 17224.6 17261.7 17332.9 17609.9 536774.0 538560.0 542814.0 544008.0 545400.0 57224.4 57295.7 57453.4 57690.0 57789.7 1235.1 1323.8 1362.2 1374.2 1375.4 32465.8 33345.3 33666.5 33759.0 33805.3 49547.5 49703.3 50039.2 50088.0 50101.0 306337.0 306374.0 307885.0 308537.0 308710.0 34996.8 40533.6 41283.6 41434.2 41466.8 46908.5 47435.5 47541.0 48421.8 48432.0 39757.9 40352.0 41079.8 41411.2 41649.8 40270.2 40513.4 41629.4 42078.4 42218.4 40099.4 40122.8 40474.2 41092.0 41331.0 35193.3 35982.6 36812.4 37157.8 37246.3 27787.3 27811.2 28041.6 28096.0 28133.9 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#2] jquery.html Cycles:180 Average:28939.95 Median:25235.12 stddev:75250.33 (298.2%) stddev-sans-first:75430.90 07:36:56 INFO - PROCESS | 11784 | Values: 391.4 398.0 410.7 412.3 420.8 14059.5 18812.7 20417.9 20463.1 20631.9 16104.9 19336.2 20207.9 20250.3 20792.3 5658.2 5839.7 5851.1 5866.4 5866.4 5562.6 5760.7 5783.2 5839.2 5845.6 5702.3 5715.0 5757.1 5759.9 5764.0 5532.1 5699.3 5713.4 5721.0 5734.4 5155.4 5163.8 5167.5 5184.8 5191.3 23196.5 24768.6 24831.6 25638.6 25659.0 2332.7 2422.9 2423.1 2633.2 2680.2 14016.9 14036.8 14446.8 14698.9 15078.8 1898.7 1930.8 1982.9 2026.3 2053.7 84871.6 85574.1 87050.6 87319.6 88326.0 9199.4 9664.1 9839.4 10279.9 10505.5 14318.8 14333.0 14367.3 14464.7 14472.6 7268.5 7388.5 7609.3 7634.0 7659.1 6600.6 7096.3 7152.2 7244.3 7440.2 4760.5 4951.6 5083.6 5100.0 5156.8 1977.9 1984.5 2048.1 2109.2 2110.3 905.8 947.3 1043.2 1059.8 1076.7 19196.7 19876.5 20529.4 20872.1 20960.8 950.6 983.6 989.3 997.0 1040.3 10934.8 11358.4 11479.8 11481.3 11514.0 444444.0 445162.0 450608.0 461331.0 461659.0 96113.5 102376.5 102481.0 102901.0 104423.0 1061.2 1062.2 1083.8 1096.9 1109.4 18200.7 18692.3 18710.6 18711.0 18878.2 43124.8 44177.0 44357.6 44388.8 45994.0 62666.4 62789.4 63519.7 63890.7 64511.0 8740.0 9151.8 9230.3 9286.5 9377.5 13970.8 14239.3 14653.7 14714.3 14894.7 12371.6 12599.9 12799.9 12815.5 12840.9 12452.2 12498.5 12594.6 12683.4 12714.9 12488.9 12686.6 12827.0 12860.5 12919.9 8905.5 9087.6 9325.4 9400.4 9442.7 10209.6 12709.4 12765.2 12772.9 12774.1 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#3] mootools.html Cycles:180 Average:5853.59 Median:2579.22 stddev:3370.28 (130.7%) stddev-sans-first:3362.46 07:36:56 INFO - PROCESS | 11784 | Values: 1313.7 1456.5 1494.9 1597.3 1768.2 8275.0 8675.0 8688.5 8919.3 8939.3 8658.7 8827.3 8836.8 8839.8 8868.0 2076.3 2139.6 2141.0 2322.9 2355.9 2319.0 2411.7 2415.4 2417.6 2422.5 2310.6 2378.5 2386.9 2393.0 2402.1 2029.4 2294.3 2299.1 2300.9 2319.2 2381.8 2414.6 2418.2 2418.6 2419.4 8711.9 8737.6 8783.0 8803.9 8806.2 5232.2 5380.5 5387.9 5395.7 5397.2 3213.3 3337.9 3443.8 3456.3 3467.9 1063.4 1064.0 1080.7 1087.0 1098.5 12322.1 12391.7 12428.8 12445.4 12519.2 4663.5 4678.2 4843.1 4887.8 4894.7 10525.9 10547.9 10554.3 10573.7 10621.2 5418.8 5431.7 5435.3 5449.3 5449.5 4200.4 4365.5 4498.6 4688.1 4990.3 4179.5 4201.9 4209.6 4245.6 4304.5 1252.7 1324.6 1331.2 1334.3 1354.5 823.7 939.4 941.8 948.2 957.8 5843.3 5886.1 5899.3 5998.4 6047.5 456.8 470.3 479.5 480.3 996.7 4087.7 4193.8 4197.5 4220.1 4226.7 10886.7 11222.6 11307.2 11307.7 11322.1 10572.1 10943.2 11028.0 11192.9 11206.6 8225.3 8422.5 8537.7 8602.9 8614.3 5942.2 5953.9 5961.7 6034.6 6061.1 10250.6 10474.8 10480.3 10503.7 10514.8 9591.1 10177.2 10610.6 10887.1 10888.4 7961.9 8071.2 8091.8 8304.2 8307.5 8029.6 8162.5 8211.0 8227.9 8261.1 7573.2 7687.2 7708.9 7788.6 7849.9 7575.3 7681.5 7696.0 7779.2 7823.3 6798.8 7022.5 7078.8 7089.0 7089.0 4946.4 5039.9 5048.1 5058.9 5076.1 5041.9 5117.8 5201.1 5265.4 5303.6 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#4] prototype.html Cycles:180 Average:4559.61 Median:5081.28 stddev:1328.65 (26.1%) stddev-sans-first:1293.70 07:36:56 INFO - PROCESS | 11784 | Values: 319.4 327.2 333.8 335.9 336.2 5155.7 5187.4 5352.9 5379.5 5381.2 5295.7 5308.2 5314.5 5326.5 5360.3 4229.0 4248.0 4255.3 4261.0 4276.5 3946.3 3993.5 4173.2 4232.9 4237.9 4152.4 4162.6 4166.7 4168.6 4171.5 4117.4 4150.9 4153.3 4155.1 4190.5 3487.8 3698.6 3724.5 3727.0 3733.4 5186.5 5211.0 5219.5 5225.8 5238.8 4728.9 4733.0 4733.1 4740.5 4742.9 5435.8 5498.5 5574.5 5582.8 5586.3 3911.0 3929.7 3930.6 3931.3 3942.1 5747.9 5750.8 5756.5 5764.2 5775.6 3924.8 4064.6 4072.6 4073.6 4073.8 4110.9 4111.9 4116.9 4122.4 4123.8 4684.4 4706.5 4720.2 4720.3 4723.6 5477.8 5604.4 5614.4 5630.9 5654.9 1401.4 1415.0 1417.6 1425.8 1427.8 874.2 896.0 911.9 912.8 916.8 4792.6 4814.2 4823.7 4828.0 4842.3 5038.9 5053.5 5072.2 5079.0 5082.2 4628.6 4812.8 4819.6 4836.2 4842.4 2638.2 2659.4 2693.0 2708.0 2716.4 5169.5 5170.3 5170.4 5171.3 5172.5 4984.3 5060.9 5172.4 5180.3 5202.3 5115.8 5195.8 5198.2 5205.0 5211.6 5030.9 5045.2 5080.3 5082.7 5118.5 4965.4 5001.4 5317.3 5797.2 5801.3 5917.3 5941.8 5958.9 5973.5 5998.0 3912.6 4074.6 4085.5 4186.5 4202.3 5670.2 5703.5 5725.7 5744.7 5754.7 5583.9 5595.6 5600.3 5606.6 5637.1 5328.7 5627.4 5662.7 5664.4 5664.4 5528.9 5555.0 5566.5 5583.9 5596.3 5331.4 5590.7 5655.2 5665.3 5685.9 5452.2 5483.6 5487.9 5491.3 5495.9 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - PROCESS | 11784 | [#5] yui.html Cycles:180 Average:21674.33 Median:27393.89 stddev:32993.60 (120.4%) stddev-sans-first:33048.57 07:36:56 INFO - PROCESS | 11784 | Values: 701.8 753.2 769.9 800.4 824.4 14986.7 15654.8 15888.3 16197.8 16267.6 15130.8 15316.2 15349.2 15378.9 15483.5 668.5 795.5 803.5 820.1 823.8 811.5 813.1 815.0 815.0 816.0 864.6 864.8 865.3 865.5 866.6 687.1 826.8 845.0 845.2 856.1 625.1 626.2 626.4 627.0 627.4 15429.5 15449.8 15453.8 15469.1 15532.8 14405.9 14529.7 14565.3 14731.3 14921.2 12239.3 12617.0 13061.7 13088.8 13413.0 3758.1 3790.5 3794.8 3807.8 3891.1 77171.2 78257.6 78263.6 78808.0 79750.6 9627.4 9746.6 9823.8 9884.4 10013.4 18876.2 18922.4 18930.8 19012.5 19143.2 7658.7 7947.6 8127.9 8538.4 8715.8 4699.5 4754.0 4812.4 4932.3 4967.9 3359.2 3462.0 3472.4 3477.2 3479.7 592.6 593.2 597.2 609.7 649.8 514.6 521.8 555.8 584.5 637.4 9208.0 9521.4 9947.8 10073.7 10091.0 634.8 656.6 660.0 661.5 668.5 3869.6 3898.6 3908.3 4015.5 4044.9 82281.0 126329.0 128120.4 129325.0 130337.0 111691.4 112989.0 113467.4 114800.0 118071.4 93441.5 93755.0 94417.0 95057.4 99375.0 7268.6 7315.6 7399.3 7520.8 7601.7 54266.0 56519.0 56569.0 57528.4 58231.7 78543.6 83389.0 84045.6 86126.0 86249.1 11424.3 11630.1 11695.1 11969.1 12074.5 13308.7 13363.5 13381.7 13844.6 14068.0 11737.5 12431.9 12687.1 12845.5 12881.9 12189.5 12506.7 12589.7 12666.4 12910.7 11837.3 11863.7 12107.1 12336.0 12349.7 9445.5 9720.7 9763.8 9987.5 10084.1 9420.9 9519.0 9598.8 9689.0 10110.2 07:36:56 INFO - PROCESS | 11784 | -------- Summary: end -------- 07:36:56 INFO - PROCESS | 11784 | 07:36:56 INFO - TEST-INFO | 11784: exit 0 07:36:56 INFO - TEST-OK | dromaeo_css | took 1112874ms 07:36:56 INFO - TEST-START | kraken 07:36:56 INFO - operating with platform_type : linux_ 07:36:56 INFO - Initialising browser for kraken test... 07:36:56 INFO - TEST-INFO | started process 11983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCwch2X/profile http://localhost:60843/getInfo.html) 07:37:00 INFO - PROCESS | 11983 | __metrics Screen width/height:1600/1200 07:37:00 INFO - PROCESS | 11983 | colorDepth:24 07:37:00 INFO - PROCESS | 11983 | Browser inner width/height: 1024/697 07:37:00 INFO - PROCESS | 11983 | __metrics 07:37:01 INFO - PROCESS | 11983 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:02 INFO - TEST-INFO | 11983: exit 0 07:37:02 INFO - Browser initialized. 07:37:02 INFO - Running cycle 1/1 for kraken test... 07:37:02 INFO - TEST-INFO | started process 12066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCwch2X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:13 INFO - PROCESS | 12066 | RSS: Main: 157220864 07:37:13 INFO - PROCESS | 12066 | 07:37:16 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60843/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:17 INFO - PROCESS | 12066 | RSS: Main: 215715840 07:37:17 INFO - PROCESS | 12066 | 07:37:19 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60843/tests/kraken/driver.html?testName=audio-dft) 07:37:20 INFO - PROCESS | 12066 | RSS: Main: 204775424 07:37:20 INFO - PROCESS | 12066 | 07:37:23 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60843/tests/kraken/driver.html?testName=audio-fft) 07:37:24 INFO - PROCESS | 12066 | RSS: Main: 269398016 07:37:24 INFO - PROCESS | 12066 | 07:37:26 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60843/tests/kraken/driver.html?testName=audio-oscillator) 07:37:26 INFO - PROCESS | 12066 | RSS: Main: 180002816 07:37:26 INFO - PROCESS | 12066 | 07:37:29 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:29 INFO - PROCESS | 12066 | RSS: Main: 185286656 07:37:29 INFO - PROCESS | 12066 | 07:37:32 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60843/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:33 INFO - PROCESS | 12066 | RSS: Main: 219369472 07:37:33 INFO - PROCESS | 12066 | 07:37:36 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60843/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:37 INFO - PROCESS | 12066 | RSS: Main: 221265920 07:37:37 INFO - PROCESS | 12066 | 07:37:40 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60843/tests/kraken/driver.html?testName=json-parse-financial) 07:37:40 INFO - PROCESS | 12066 | RSS: Main: 221462528 07:37:40 INFO - PROCESS | 12066 | 07:37:42 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:42 INFO - PROCESS | 12066 | RSS: Main: 208867328 07:37:42 INFO - PROCESS | 12066 | 07:37:44 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:45 INFO - PROCESS | 12066 | RSS: Main: 212492288 07:37:45 INFO - PROCESS | 12066 | 07:37:47 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:47 INFO - PROCESS | 12066 | RSS: Main: 210354176 07:37:47 INFO - PROCESS | 12066 | 07:37:50 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:50 INFO - PROCESS | 12066 | RSS: Main: 224378880 07:37:50 INFO - PROCESS | 12066 | 07:37:53 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:54 INFO - PROCESS | 12066 | RSS: Main: 224747520 07:37:54 INFO - PROCESS | 12066 | 07:37:55 INFO - PROCESS | 12066 | Cycle 1(1): loaded http://localhost:60843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60843/tests/kraken/driver.html?testName=ai-astar) 07:37:56 INFO - PROCESS | 12066 | RSS: Main: 267710464 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | __start_tp_report 07:37:56 INFO - PROCESS | 12066 | _x_x_mozilla_page_load 07:37:56 INFO - PROCESS | 12066 | _x_x_mozilla_page_load_details 07:37:56 INFO - PROCESS | 12066 | |i|pagename|runs| 07:37:56 INFO - PROCESS | 12066 | |0;ai-astar;99;109;111;112;111;110;109;109;111;110 07:37:56 INFO - PROCESS | 12066 | |1;audio-beat-detection;147;117;119;162;118;118;145;118;162;118 07:37:56 INFO - PROCESS | 12066 | |2;audio-dft;161;159;161;161;162;160;160;159;160;161 07:37:56 INFO - PROCESS | 12066 | |3;audio-fft;75;74;76;111;75;74;74;74;113;76 07:37:56 INFO - PROCESS | 12066 | |4;audio-oscillator;84;82;112;84;84;84;116;84;83;135 07:37:56 INFO - PROCESS | 12066 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;117 07:37:56 INFO - PROCESS | 12066 | |6;imaging-darkroom;146;145;145;145;146;146;146;147;145;146 07:37:56 INFO - PROCESS | 12066 | |7;imaging-desaturate;95;96;96;95;96;95;95;95;95;95 07:37:56 INFO - PROCESS | 12066 | |8;json-parse-financial;55;53;53;53;53;53;53;52;53;53 07:37:56 INFO - PROCESS | 12066 | |9;json-stringify-tinderbox;61;61;60;62;61;60;60;62;61;61 07:37:56 INFO - PROCESS | 12066 | |10;stanford-crypto-aes;82;76;80;75;80;76;83;75;75;79 07:37:56 INFO - PROCESS | 12066 | |11;stanford-crypto-ccm;119;116;117;118;123;128;119;117;159;124 07:37:56 INFO - PROCESS | 12066 | |12;stanford-crypto-pbkdf2;158;162;155;161;160;159;157;158;156;158 07:37:56 INFO - PROCESS | 12066 | |13;stanford-crypto-sha256-iterative;62;62;62;63;62;65;62;62;62;65 07:37:56 INFO - PROCESS | 12066 | __end_tp_report 07:37:56 INFO - PROCESS | 12066 | __start_cc_report 07:37:56 INFO - PROCESS | 12066 | _x_x_mozilla_cycle_collect,1660 07:37:56 INFO - PROCESS | 12066 | __end_cc_report 07:37:56 INFO - PROCESS | 12066 | __startTimestamp1467383876087__endTimestamp 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | ------- Summary: start ------- 07:37:56 INFO - PROCESS | 12066 | Number of tests: 14 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.70 (3.3%) stddev-sans-first:1.09 07:37:56 INFO - PROCESS | 12066 | Values: 99.0 109.0 111.0 112.0 111.0 110.0 109.0 109.0 111.0 110.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:132.00 stddev:19.35 (14.7%) stddev-sans-first:19.79 07:37:56 INFO - PROCESS | 12066 | Values: 147.0 117.0 119.0 162.0 118.0 118.0 145.0 118.0 162.0 118.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 07:37:56 INFO - PROCESS | 12066 | Values: 161.0 159.0 161.0 161.0 162.0 160.0 160.0 159.0 160.0 161.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:15.73 (21.1%) stddev-sans-first:16.47 07:37:56 INFO - PROCESS | 12066 | Values: 75.0 74.0 76.0 111.0 75.0 74.0 74.0 74.0 113.0 76.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:19.00 (22.6%) stddev-sans-first:19.74 07:37:56 INFO - PROCESS | 12066 | Values: 84.0 82.0 112.0 84.0 84.0 84.0 116.0 84.0 83.0 135.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:37:56 INFO - PROCESS | 12066 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:37:56 INFO - PROCESS | 12066 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 146.0 147.0 145.0 146.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:37:56 INFO - PROCESS | 12066 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.33 07:37:56 INFO - PROCESS | 12066 | Values: 55.0 53.0 53.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 07:37:56 INFO - PROCESS | 12066 | Values: 61.0 61.0 60.0 62.0 61.0 60.0 60.0 62.0 61.0 61.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:79.50 stddev:3.07 (3.9%) stddev-sans-first:2.92 07:37:56 INFO - PROCESS | 12066 | Values: 82.0 76.0 80.0 75.0 80.0 76.0 83.0 75.0 75.0 79.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:121.00 stddev:12.87 (10.6%) stddev-sans-first:13.52 07:37:56 INFO - PROCESS | 12066 | Values: 119.0 116.0 117.0 118.0 123.0 128.0 119.0 117.0 159.0 124.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:2.17 (1.4%) stddev-sans-first:2.30 07:37:56 INFO - PROCESS | 12066 | Values: 158.0 162.0 155.0 161.0 160.0 159.0 157.0 158.0 156.0 158.0 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - PROCESS | 12066 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.30 07:37:56 INFO - PROCESS | 12066 | Values: 62.0 62.0 62.0 63.0 62.0 65.0 62.0 62.0 62.0 65.0 07:37:56 INFO - PROCESS | 12066 | -------- Summary: end -------- 07:37:56 INFO - PROCESS | 12066 | 07:37:56 INFO - TEST-INFO | 12066: exit 0 07:37:57 INFO - TEST-OK | kraken | took 60093ms 07:37:57 INFO - SUITE-END | took 1172s 07:37:57 INFO - Completed test suite (00:19:33) 07:37:57 INFO - javascript benchmark 07:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.9385012299754, 3092.7061929116726, 3107.0523490335445, 3121.6410112837, 3148.5434611981264, 5069.695818250908, 5141.383034035921, 5271.393789714184, 5331.653442526238, 5353.678779273241, 5172.069027575044, 5243.213517972306, 5248.448912864152, 5305.549028332587, 5314.202869569566, 4763.61891048717, 4855.126077306083, 4865.367502224706, 4869.123557759602, 5011.949880501203, 4930.679505832128, 4986.252062190664, 4988.825391111312, 4991.850244492653, 5008.9499105008845, 4774.904501909959, 4802.399700037513, 4818.927716084261, 4830.323754674313, 4857.854264372057, 4794.113089078532, 4805.735684537349, 4807.375041244616, 4880.267959806022, 4921.557059864629, 4807.951920480786, 4831.830885918976, 4843.733594652293, 4868.245421959602, 4891.437484689271, 5119.411267704225, 5206.557442617382, 5326.280952071498, 5367.892642147135, 5393.83818485446, 5792.391798861101, 5804.448577385142, 5824.679642619654, 5826.0, 5827.825165245049, 5845.941540584582, 5846.941530584725, 5887.322957859858, 5895.233619629464, 5897.292324920994, 5150.072986862363, 5182.455842136559, 5196.8960620787375, 5217.0, 5474.206240095204, 5766.509846663081, 5770.913436298459, 5775.249217601769, 5781.132830075522, 5781.566382521243, 5517.751701173457, 5525.585581081355, 5560.304961879765, 5564.777408903598, 5570.749316280777, 5480.588955828249, 5551.444855514497, 5585.469380408855, 5591.552675785927, 5634.352049514277, 5552.583556233299, 5606.411326810708, 5607.719614019283, 5614.6631202128, 5615.943840561624, 5540.833774986757, 5558.555315574744, 5558.72206389687, 5562.749676264497, 5608.439156084359, 4242.44848169736, 4254.829806807693, 4260.616544510947, 4271.914561708749, 4296.441462609903, 3820.980895095562, 3839.5584507781405, 3840.9039774005873, 3859.7877116758846, 3862.6909847212155, 5225.320708307896, 5257.684538927677, 5305.708186049727, 5311.49540793624, 5366.0, 5632.127020311858, 5654.547636189095, 5709.400512946081, 5714.200011998323, 5744.655320680772, 5399.649022813504, 5402.0, 5407.459254074561, 5409.594280428905, 5411.648242864201, 4805.3512775774825, 4847.127517046895, 4944.220707782225, 4950.158473059589, 5003.3495645565845, 5744.253247077853, 5812.796552120655, 5813.5349172066135, 5815.73829177688, 5880.088586269135, 5634.0, 5648.604597678123, 5649.491545760737, 5650.124230744241, 5663.773449061991, 5663.66018038919, 5782.10377391505, 5798.82603521895, 5896.439838215363, 5960.821175364746, 5648.350439699487, 5654.208410822406, 5661.320641523043, 5670.943290567042, 5714.399988001366, 5725.599208055396, 5743.0811070228565, 5752.367239603724, 5756.165356023437, 5773.364929857797, 5450.155225939986, 5524.116141417515, 5537.8061767837935, 5595.664260144405, 5603.131514615241, 5583.972080139573, 5586.972065139648, 5591.4688104629995, 5591.608587398843, 5592.860178495407, 5462.235287059735, 5464.1257398816, 5491.395946445968, 5512.80705175317, 5554.555635549227, 5421.674699518042, 5421.83734487966, 5429.484199001088, 5467.4532546745, 5473.863153421196, 5339.225812257278, 5359.839204823861, 5369.382521010134, 5369.48989845964, 5370.436104209158], "value": 5226.319619851349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9738111784969, 617.1175219436205, 620.3672254300614, 636.7453018792486, 638.9872052796318, 42798.35802462962, 43974.780126099366, 44020.3396949046, 44106.338404923954, 47082.529174708245, 45346.093078138416, 45727.31409028867, 45797.31304030442, 45801.541984580144, 45835.31247031297, 8958.955205223965, 9029.729108126734, 9097.63609455621, 9101.271898248157, 9109.544522773835, 8940.06129356418, 8998.415103018282, 9010.27917766577, 9027.14242146995, 9037.41256818308, 9090.63637454501, 9125.634974601042, 9130.406523575979, 9132.178103970642, 9139.908600913972, 9000.414973026733, 9008.59461324242, 9039.548022598876, 9044.688520164606, 9067.229285510739, 8855.911440885573, 8907.242884354837, 8926.509042002688, 8928.687495937676, 8929.955350223272, 43085.78457107695, 43404.0, 43582.564174358165, 43594.78202608998, 43599.0, 3551.5383000210068, 3650.7444478886487, 3658.8353524091212, 3898.610138986107, 4206.72656277341, 32574.348513029843, 32869.17827054343, 33146.0, 33184.17039574006, 34097.56731624873, 3649.8905032849057, 3877.9806100969595, 3931.331673615492, 3955.4857868476915, 3979.900502487432, 319531.0, 319790.0, 320367.0, 320870.0, 321005.0, 51640.48359516432, 58473.0, 58680.70659646674, 58989.70505147533, 59071.40928590659, 61416.0, 61466.0, 61466.69266653638, 61561.0, 61578.0, 13557.186568805902, 13564.321783910962, 13586.592402227949, 13701.520446784514, 13780.93109534466, 10470.424126673106, 10640.095591874622, 10648.094911932418, 10650.520726567323, 10654.094401975764, 15218.239088045553, 16744.748828767577, 16763.91618041902, 16806.747898781527, 16879.662406752042, 5612.550995920316, 5621.353544342453, 5681.829545113653, 5689.459501347365, 5737.340205876294, 947.2185447006248, 1025.9076683098558, 1061.124572227915, 1119.7243755383213, 1179.8761130081389, 32233.67766322307, 32281.192970175933, 32631.4789918484, 32748.181295467326, 33236.83381583125, 1075.5536452372335, 1077.9813076642497, 1081.751197224627, 1112.6161474291357, 1210.4250481021445, 16570.0, 17224.569385765455, 17261.741073883903, 17332.91333543324, 17609.911950440164, 536774.0, 538560.0, 542814.0, 544008.0, 545400.0, 57224.42775572191, 57295.713521432124, 57453.42546574564, 57690.0, 57789.71105144447, 1235.1415766042694, 1323.7815760399426, 1362.1963041805382, 1374.1892283552552, 1375.408574313055, 32465.837670811496, 33345.33309333751, 33666.49500257547, 33759.0, 33805.32389352249, 49547.50452495573, 49703.25445118399, 50039.24941125813, 50088.0, 50101.0, 306337.0, 306374.0, 307885.0, 308537.0, 308710.0, 34996.825015874754, 40533.59466405298, 41283.587164129174, 41434.171316572894, 41466.792666036476, 46908.53091469178, 47435.52564474311, 47541.0, 48421.757891211724, 48432.0, 39757.885627319025, 40352.0, 41079.794601028, 41411.1717765649, 41649.79175104105, 40270.1945961085, 40513.39229911612, 41629.37555936724, 42078.36882446827, 42218.36672449977, 40099.39850902297, 40122.79938600288, 40474.19051618892, 41092.0, 41331.0, 35193.29613407666, 35982.64017359793, 36812.447813282284, 37157.81421092877, 37246.255074898894, 27787.30531736642, 27811.165665030083, 28041.57937630978, 28096.0, 28133.859330703217], "value": 19782.192951300873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.44805823788454, 397.99602003979953, 410.71455338539727, 412.2702816015652, 420.8274607410962, 14059.5079172229, 18812.717809232872, 20417.897910510444, 20463.079161437752, 20631.896840515816, 16104.919475402636, 19336.226550937947, 20207.898960505212, 20250.29123980661, 20792.272270470537, 5658.179563963233, 5839.737211825478, 5851.093080572518, 5866.413358664142, 5866.442687944638, 5562.582806289524, 5760.683162426065, 5783.219265399181, 5839.240898683165, 5845.5908086433965, 5702.3157221133315, 5715.028445164311, 5757.107648314518, 5759.913601295984, 5764.048931926227, 5532.1425179097505, 5699.344575373843, 5713.400092990239, 5720.971395142998, 5734.4265573442735, 5155.355580552431, 5163.8192663256605, 5167.48325167484, 5184.792608295701, 5191.273221748958, 23196.53606927852, 24768.628470572956, 24831.62752558713, 25638.615420768703, 25659.0, 2332.720073591163, 2422.878856057208, 2423.0550085466684, 2633.210036988915, 2680.222735406749, 14016.85983140176, 14036.789448158286, 14446.783298250535, 14698.926505367512, 15078.773818392732, 1898.6582415165265, 1930.8165724256173, 1982.930597429083, 2026.311054241565, 2053.722747429093, 84871.57564212201, 85574.14425855724, 87050.5647471765, 87319.56340218322, 88325.99999999936, 9199.356045076915, 9664.130228279488, 9839.409635421755, 10279.897201028043, 10505.474726263656, 14318.785218221736, 14333.0, 14367.28163591837, 14464.710705785825, 14472.565823025116, 7268.45486588508, 7388.519746216479, 7609.315161635479, 7634.0, 7659.119201291923, 6600.636964966973, 7096.325849044332, 7152.249013853574, 7244.275572442713, 7440.218777028443, 4760.523947605212, 4951.554360107608, 5083.567896728746, 5100.0364859529345, 5156.819511317086, 1977.8714383565023, 1984.5237143085556, 2048.09883651193, 2109.1563374650264, 2110.3457928042358, 905.7509184974053, 947.2564037230741, 1043.2019505078622, 1059.7721489879714, 1076.7200527862813, 19196.71204931927, 19876.50308742293, 20529.384118476468, 20872.06075726596, 20960.798544485613, 950.5864948747317, 983.6360546597662, 989.302541708094, 996.9651062212788, 1040.2614143957874, 10934.835977460345, 11358.432078396047, 11479.827802582968, 11481.253718508271, 11514.0, 444444.0, 445162.0, 450608.0, 461331.0, 461659.0, 96113.51943240239, 102376.48811755894, 102481.0, 102901.0, 104423.0, 1061.1828891753307, 1062.1821197677746, 1083.8482612434266, 1096.873859506167, 1109.4120116338354, 18200.72698909491, 18692.25230990745, 18710.625787483903, 18711.0, 18878.24487020504, 43124.78437607917, 44177.0, 44357.556424435345, 44388.77805610951, 45994.0, 62666.373336267876, 62789.37210628018, 63519.6824015877, 63890.68054659697, 64511.0, 8739.956300218459, 9151.816963660556, 9230.307726920642, 9286.489243091424, 9377.531123443938, 13970.797312195487, 14239.288035597972, 14653.706925861636, 14714.337854796346, 14894.702105958037, 12371.566995155126, 12599.87400125987, 12799.872001279868, 12815.462144542715, 12840.871591283967, 12452.190607610477, 12498.500059997861, 12594.559190428292, 12683.365831708194, 12714.936425317814, 12488.937555312528, 12686.619401417973, 12827.0, 12860.549880754128, 12919.935400322938, 8905.51019693923, 9087.59105840252, 9325.440473571607, 9400.435973841591, 9442.669506567237, 10209.642662506776, 12709.364531773559, 12765.170263932814, 12772.87227127754, 12774.105812593029], "value": 9543.316774740671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.6650154210674, 1456.5047883719533, 1494.8804095672347, 1597.337105101383, 1768.1601239411282, 8274.958625206873, 8675.045744968056, 8688.522131282769, 8919.331050171231, 8939.329550283723, 8658.696945606906, 8827.33794965377, 8836.779080522974, 8839.823203535925, 8867.955660221689, 2076.3148161106797, 2139.5613899150635, 2140.9892950535227, 2322.8606283622994, 2355.8704271265074, 2318.9536209275802, 2411.6623672685837, 2415.420299128214, 2417.576924038295, 2422.527607116613, 2310.5609934112463, 2378.4886249456363, 2386.9283921482383, 2393.0, 2402.135231316733, 2029.3810387831707, 2294.3346429535413, 2299.1033496936207, 2300.87345196015, 2319.1998760427628, 2381.7975472084895, 2414.553307638075, 2418.238254949685, 2418.600930846408, 2419.4193393585415, 8711.869321960112, 8737.563121843883, 8783.0, 8803.911960880374, 8806.20744133031, 5232.162853943389, 5380.488853558905, 5387.919181212285, 5395.676259424447, 5397.217403476513, 3213.2770126721534, 3337.8998630041137, 3443.810590417526, 3456.3260164267977, 3467.8959631211105, 1063.4310643805604, 1064.0317311246806, 1080.6649938519006, 1087.0488322717622, 1098.4672433869566, 12322.137450378477, 12391.690207744788, 12428.813567796491, 12445.439955202037, 12519.248845069234, 4663.51033141522, 4678.157931572282, 4843.128236917389, 4887.780049897763, 4894.657373983858, 10525.89474105249, 10547.947260263803, 10554.313969592105, 10573.682789516326, 10621.150307975498, 5418.83743487696, 5431.701256430934, 5435.320584926884, 5449.3460784706085, 5449.455054494598, 4200.3699445082875, 4365.454318210223, 4498.640108791289, 4688.109259240733, 4990.326305948723, 4179.477565304337, 4201.936970945439, 4209.621134097946, 4245.5542168072525, 4304.526502084768, 1252.7056141806668, 1324.569514907659, 1331.1680199875077, 1334.3395019465427, 1354.525915929417, 823.6869989404108, 939.3753154152548, 941.8304705153001, 948.2035090523993, 957.8084383123403, 5843.29880414353, 5886.117082437583, 5899.262592175978, 5998.430149135826, 6047.455728984412, 456.78074524228555, 470.3274317725685, 479.549223729693, 480.28677414040123, 996.6611352140308, 4087.713860029829, 4193.832246710159, 4197.496300443966, 4220.07158425146, 4226.661867050629, 10886.67339979802, 11222.55109795599, 11307.208495405243, 11307.717307067389, 11322.094232461382, 10572.101371383365, 10943.179261555415, 11028.0, 11192.944035279934, 11206.607768728056, 8225.341972642174, 8422.494650321001, 8537.74386768398, 8602.913970860336, 8614.26778723803, 5942.1978032965, 5953.910691339547, 5961.701914904324, 6034.577579569564, 6061.090836374579, 10250.641227557298, 10474.842877356998, 10480.266381353233, 10503.737406564896, 10514.842277365999, 9591.136797688241, 10177.18582513412, 10610.575576976835, 10887.074598659203, 10888.40113793749, 7961.9203807963495, 8071.152528984372, 8091.797705057185, 8304.211099945496, 8307.543085130375, 8029.5583742894705, 8162.510249385056, 8210.958945205475, 8227.876581851397, 8261.091279959079, 7573.2048134947245, 7687.154413014676, 7708.922910771045, 7788.571628560484, 7849.921500785147, 7575.318221360104, 7681.539107653559, 7696.0, 7779.222077792176, 7823.295903368724, 6798.830029249309, 7022.473314501331, 7078.823029424306, 7088.964555177191, 7089.042979197949, 4946.35697359341, 5039.874003149804, 5048.116579598629, 5058.898822023465, 5076.086304465084, 5041.899162016666, 5117.795288188431, 5201.141811601044, 5265.394479634738, 5303.602229832701], "value": 4609.356536554137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.4393838812883, 327.1787812590398, 333.78971248113686, 335.90762540301404, 336.1763678986484, 5155.71643559604, 5187.377514698242, 5352.892942141159, 5379.488948549892, 5381.192821076836, 5295.708736019517, 5308.150695888658, 5314.495122963322, 5326.467353264671, 5360.3299587551555, 4228.957710422903, 4248.0, 4255.319148936171, 4261.0, 4276.486821581415, 3946.3488524393442, 3993.480847489837, 4173.227952828721, 4232.936505952413, 4237.872863814075, 4152.356384760352, 4162.625363717265, 4166.729162604436, 4168.583141685823, 4171.520275168349, 4117.423560701504, 4150.92076060225, 4153.273177193994, 4155.148194620126, 4190.51809041961, 3487.8256087195537, 3698.5760482214273, 3724.4599533067826, 3726.950177402418, 3733.383991641376, 5186.507281808223, 5211.0359583477175, 5219.530242278175, 5225.790968361261, 5238.795077132243, 4728.858134255978, 4732.952670473285, 4733.148033353995, 4740.549647783455, 4742.861713188844, 5435.755391007414, 5498.505134537871, 5574.470425309589, 5582.845692183903, 5586.329640443173, 3910.9608903911167, 3929.6659783918403, 3930.64624183822, 3931.312020396419, 3942.1327307992483, 5747.885042299173, 5750.7987220447085, 5756.539476841885, 5764.16419619157, 5775.624584402, 3924.843006279717, 4064.634182923551, 4072.554243243606, 4073.572274911151, 4073.816678249427, 4110.876673699734, 4111.9177616447505, 4116.855910043134, 4122.40225167349, 4123.824709957647, 4684.4378674559275, 4706.529347065266, 4720.221163508051, 4720.291956206528, 4723.574878260973, 5477.835664930059, 5604.41153678866, 5614.382417934024, 5630.943690563042, 5654.9151762723595, 1401.3833913078213, 1414.978775318371, 1417.5676418692399, 1425.8217722784652, 1427.7572812621672, 874.2350443362059, 896.0054339682947, 911.910267230653, 912.7672443526991, 916.7616419730784, 4792.592629626521, 4814.20565606678, 4823.662343635982, 4827.951720482821, 4842.273658951185, 5038.924416133761, 5053.46938571452, 5072.163093089673, 5078.974605127025, 5082.237664350377, 4628.552890973986, 4812.783424745895, 4819.614430845524, 4836.153673107192, 4842.394700662418, 2638.2349118755346, 2659.3617531792615, 2692.9730702693114, 2707.9593806092926, 2716.388812517168, 5169.508896654812, 5170.302009228782, 5170.405403378584, 5171.32772739549, 5172.482751724798, 4984.283565456834, 5060.886604946906, 5172.353455818023, 5180.326557547494, 5202.271681964528, 5115.820946266863, 5195.818146364859, 5198.194279886624, 5205.0, 5211.644972307227, 5030.924536131888, 5045.217991211368, 5080.314157588678, 5082.669626474268, 5118.513741194581, 4965.354503914613, 5001.42483614389, 5317.308749862493, 5797.246308003833, 5801.274840644919, 5917.260342457193, 5941.762329506944, 5958.880822383615, 5973.49225315853, 5998.040313549811, 3912.5696173420333, 4074.5721699221153, 4085.5301640311745, 4186.455760751083, 4202.27706640276, 5670.206171135962, 5703.490464195741, 5725.713714314351, 5744.741486633196, 5754.6547207167705, 5583.916241256303, 5595.580331475075, 5600.327960644749, 5606.635568688022, 5637.126245431965, 5328.733563321741, 5627.409122042127, 5662.688552129508, 5664.357336372406, 5664.433556644467, 5528.917066243929, 5554.972225138848, 5566.471185237558, 5583.916241256303, 5596.272484576979, 5331.440198779227, 5590.664560126405, 5655.151727240782, 5665.263515742927, 5685.943140568541, 5452.182172674131, 5483.643563168382, 5487.862803429946, 5491.341039075336, 5495.917561236504], "value": 4136.233849709867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8140192848895, 753.1564647594695, 769.8883661869029, 800.3677095094876, 824.4146655874329, 14986.700265994674, 15654.765178522317, 15888.285027173775, 16197.757033644475, 16267.593310167253, 15130.773038404433, 15316.234188290597, 15349.155796431192, 15378.923475356729, 15483.458078967238, 668.4919461209491, 795.5107608820563, 803.4777394693452, 820.0774129104757, 823.7569916874506, 811.5171472973601, 813.1421350475247, 815.0, 815.042325267811, 816.0452270843127, 864.5504337744369, 864.8486514859906, 865.3034307382554, 865.4763867859948, 866.6360128745911, 687.0724521895451, 826.7891687619649, 844.9915500844975, 845.2308399356587, 856.0968178571604, 625.0561651905609, 626.1734510446213, 626.3955283151735, 627.0030651264466, 627.3600927054379, 15429.459968901147, 15449.845501544953, 15453.845461545354, 15469.149196794171, 15532.844671553254, 14405.92797036008, 14529.709405811824, 14565.344559494848, 14731.337089830984, 14921.179335136563, 12239.265644061385, 12617.0, 13061.673458163621, 13088.79324565478, 13413.0, 3758.1168425420005, 3790.5261842269715, 3794.810259487042, 3807.847686092553, 3891.1439483313625, 77171.22828771696, 78257.60871195665, 78263.6086819568, 78808.0, 79750.60124699397, 9627.422354658744, 9746.561404736804, 9823.803523929482, 9884.357516761387, 10013.449260290608, 18876.150573224237, 18922.432327030212, 18930.810691892904, 19012.524686882938, 19143.2342706293, 7658.73194438192, 7947.602619868983, 8127.878081828777, 8538.44500107491, 8715.825683486295, 4699.483056863743, 4753.9762301188275, 4812.422509298836, 4932.26016097581, 4967.925481117786, 3359.160209947513, 3462.0479368173956, 3472.357613841397, 3477.1654802847133, 3479.7390195734915, 592.63552914957, 593.2258402784322, 597.2146627185238, 609.713434685697, 649.7985624456434, 514.6448950224408, 521.7756364763112, 555.8221369161829, 584.4593750780512, 637.445422482434, 9207.953960230156, 9521.381110227952, 9947.768989702943, 10073.748156296151, 10091.0, 634.8444631065327, 656.6322859198864, 659.953803233769, 661.503872095928, 668.4585485756455, 3869.613038696164, 3898.5516665583255, 3908.257431088084, 4015.5382131054716, 4044.8786536403954, 82281.0, 126329.0, 128120.35939820242, 129325.0, 130337.0, 111691.44154279177, 112989.0, 113467.4326628378, 114800.0, 118071.40964295123, 93441.53279233561, 93755.0, 94417.0, 95057.39398919267, 99375.0, 7268.563886166847, 7315.6342182889575, 7399.297066778648, 7520.774376768706, 7601.695932162652, 54266.0, 56519.0, 56569.0, 57528.424715752306, 58231.70884145552, 78543.60728196322, 83389.0, 84045.57977210075, 86126.0, 86249.13750862662, 11424.314541127558, 11630.127740419672, 11695.064394848221, 11969.102317326062, 12074.45664945097, 13308.667283317607, 13363.53227637028, 13381.732365352833, 13844.584662460142, 14068.0, 11737.530498779954, 12431.875681243071, 12687.11190216676, 12845.486180552673, 12881.871181288067, 12189.451474683483, 12506.749865002466, 12589.748205035665, 12666.430010649727, 12910.67723306925, 11837.348945807718, 11863.703407414883, 12107.091968102604, 12336.0, 12349.691257718629, 9445.527723613654, 9720.708378748648, 9763.78422444489, 9987.500624968578, 10084.142847858015, 9420.858687119562, 9518.95240523793, 9598.808023839345, 9688.951555242178, 10110.241731869992], "value": 7321.5453348832, "unit": "score"}], "name": "dromaeo_css", "value": 7186.389094836704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 111.0, 112.0, 111.0, 110.0, 109.0, 109.0, 111.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 119.0, 162.0, 118.0, 118.0, 145.0, 118.0, 162.0, 118.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 161.0, 162.0, 160.0, 160.0, 159.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 111.0, 75.0, 74.0, 74.0, 74.0, 113.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 112.0, 84.0, 84.0, 84.0, 116.0, 84.0, 83.0, 135.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 80.0, 75.0, 80.0, 76.0, 83.0, 75.0, 75.0, 79.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 117.0, 118.0, 123.0, 128.0, 119.0, 117.0, 159.0, 124.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 155.0, 161.0, 160.0, 159.0, 157.0, 158.0, 156.0, 158.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 65.0, 62.0, 62.0, 62.0, 65.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1473.8, "alertThreshold": 2.0}]} 07:37:57 INFO - Return code: 0 07:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:57 INFO - # TBPL SUCCESS # 07:37:57 INFO - Running post-action listener: _resource_record_post_action 07:37:57 INFO - ##### 07:37:57 INFO - ##### Finished run-tests step (success) 07:37:57 INFO - ##### 07:37:57 INFO - Running post-run listener: _resource_record_post_run 07:37:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565780480; Read time: 16; Write time: 462916 07:37:57 INFO - TinderboxPrint: CPU usage
13.0% 07:37:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:37:57 INFO - TinderboxPrint: I/O write bytes / time
565,780,480 / 462,916 07:37:57 INFO - TinderboxPrint: CPU idle
8,266.9 (87.0%) 07:37:57 INFO - TinderboxPrint: CPU user
1,196.8 (12.6%) 07:37:57 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 268042240; Read time: 0; Write time: 256220 07:37:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293765120; Read time: 0; Write time: 206260 07:37:58 INFO - Running post-run listener: _upload_blobber_files 07:37:58 INFO - Blob upload gear active. 07:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:59 INFO - (blobuploader) - INFO - Done attempting. 07:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:00 INFO - (blobuploader) - INFO - Done attempting. 07:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:03 INFO - (blobuploader) - INFO - Done attempting. 07:38:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:03 INFO - Return code: 0 07:38:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f27a0b1d5e6b5b1402075676ef84e39123956e4dc54e3484efa0211364cc4966f782c502fcc1bd5988759896c2d15ff32e7bc26086c9f16f9b06d67811fb0c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03d11d1e577c6103c2b599ee4b77e254ed80e48ae714454866e31935bcf75a9183e3ecdcbab1a8edcf40f4e582281f7dc03949f3c242ddc472c170e81ba2983f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6bb656585ec8de665fda9f84b1d1082d9a7afa871bef8ba60f901a0f9f569e4a964a0496ce5a82bf5872a45e0d9171b555a7322eda192aeb290a738b986f694"} 07:38:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:03 INFO - Contents: 07:38:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f27a0b1d5e6b5b1402075676ef84e39123956e4dc54e3484efa0211364cc4966f782c502fcc1bd5988759896c2d15ff32e7bc26086c9f16f9b06d67811fb0c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03d11d1e577c6103c2b599ee4b77e254ed80e48ae714454866e31935bcf75a9183e3ecdcbab1a8edcf40f4e582281f7dc03949f3c242ddc472c170e81ba2983f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6bb656585ec8de665fda9f84b1d1082d9a7afa871bef8ba60f901a0f9f569e4a964a0496ce5a82bf5872a45e0d9171b555a7322eda192aeb290a738b986f694"} 07:38:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:03 INFO - Copying logs to upload dir... 07:38:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.797456 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-01 07:38:03.582857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 07:38:03.586592) ========= 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=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f27a0b1d5e6b5b1402075676ef84e39123956e4dc54e3484efa0211364cc4966f782c502fcc1bd5988759896c2d15ff32e7bc26086c9f16f9b06d67811fb0c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03d11d1e577c6103c2b599ee4b77e254ed80e48ae714454866e31935bcf75a9183e3ecdcbab1a8edcf40f4e582281f7dc03949f3c242ddc472c170e81ba2983f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6bb656585ec8de665fda9f84b1d1082d9a7afa871bef8ba60f901a0f9f569e4a964a0496ce5a82bf5872a45e0d9171b555a7322eda192aeb290a738b986f694"} build_url:https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/FkZ46zyPSCyYf-YpFl7f7w/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/Mozilla-Inbound/sha512/f27a0b1d5e6b5b1402075676ef84e39123956e4dc54e3484efa0211364cc4966f782c502fcc1bd5988759896c2d15ff32e7bc26086c9f16f9b06d67811fb0c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03d11d1e577c6103c2b599ee4b77e254ed80e48ae714454866e31935bcf75a9183e3ecdcbab1a8edcf40f4e582281f7dc03949f3c242ddc472c170e81ba2983f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6bb656585ec8de665fda9f84b1d1082d9a7afa871bef8ba60f901a0f9f569e4a964a0496ce5a82bf5872a45e0d9171b555a7322eda192aeb290a738b986f694"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 07:38:03.612483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:38:03.612843) ========= 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=0333a256a5e4f052382dd180000001b1-1467379749.174519-830961142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:38:03.696915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 07:38:03.697259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 07:38:03.697587) ========= ========= Total master_lag: 0.18 =========