builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1478915041.56 results: success (0) buildid: 20161111133014 builduid: 0511addcaf71485982a36c0b305aeafd revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.558608) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.559030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.559309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.623960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.624305) ========= 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=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 17:44:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-11-11 17:44:01 (38.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080169 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.730372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.736746) ========= 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=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023267 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.795189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:01.795516) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --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=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 17:44:01,934 truncating revision to first 12 chars 2016-11-11 17:44:01,934 Setting DEBUG logging. 2016-11-11 17:44:01,934 attempt 1/10 2016-11-11 17:44:01,934 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d1c54f240d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 17:44:02,411 unpacking tar archive at: mozilla-central-5d1c54f240d0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.806526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:02.619382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:02.619730) ========= script_repo_revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:02.620120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:02.620393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 17:44:02.647754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-11 17:44:02.648034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:02 INFO - MultiFileLogger online at 20161111 17:44:02 in /builds/slave/test 17:44:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:44:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:02 INFO - {'append_to_log': False, 17:44:02 INFO - 'base_work_dir': '/builds/slave/test', 17:44:02 INFO - 'blob_upload_branch': 'Firefox', 17:44:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:02 INFO - 'branch': 'Firefox', 17:44:02 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:02 INFO - 'config_files': ('talos/linux_config.py',), 17:44:02 INFO - 'default_actions': ('clobber', 17:44:02 INFO - 'read-buildbot-config', 17:44:02 INFO - 'download-and-extract', 17:44:02 INFO - 'populate-webroot', 17:44:02 INFO - 'create-virtualenv', 17:44:02 INFO - 'install', 17:44:02 INFO - 'run-tests'), 17:44:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:02 INFO - 'download_minidump_stackwalk': True, 17:44:02 INFO - 'download_symbols': 'ondemand', 17:44:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:44:02 INFO - 'tooltool.py': '/tools/tooltool.py', 17:44:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:44:02 INFO - '/tools/misc-python/virtualenv.py')}, 17:44:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:02 INFO - 'installer_path': 'installer.exe', 17:44:02 INFO - 'log_level': 'info', 17:44:02 INFO - 'log_name': 'talos', 17:44:02 INFO - 'log_to_console': True, 17:44:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:02 INFO - 'opt_config_files': (), 17:44:02 INFO - 'pip_index': False, 17:44:02 INFO - 'sps_profile': False, 17:44:02 INFO - 'sps_profile_interval': 0, 17:44:02 INFO - 'suite': 'dromaeojs-e10s', 17:44:02 INFO - 'system_bits': '32', 17:44:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:02 INFO - 'title': 'talos-linux64-ix-009', 17:44:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:02 INFO - 'use_talos_json': True, 17:44:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:02 INFO - 'work_dir': 'build'} 17:44:02 INFO - [mozharness: 2016-11-12 01:44:02.884624Z] Running clobber step. 17:44:02 INFO - Running pre-action listener: _resource_record_pre_action 17:44:02 INFO - Running main action method: clobber 17:44:02 INFO - rmtree: /builds/slave/test/build 17:44:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:03 INFO - Running post-action listener: _resource_record_post_action 17:44:03 INFO - [mozharness: 2016-11-12 01:44:03.354135Z] Finished clobber step (success) 17:44:03 INFO - [mozharness: 2016-11-12 01:44:03.354235Z] Running read-buildbot-config step. 17:44:03 INFO - Running pre-action listener: _resource_record_pre_action 17:44:03 INFO - Running main action method: read_buildbot_config 17:44:03 INFO - Using buildbot properties: 17:44:03 INFO - { 17:44:03 INFO - "project": "", 17:44:03 INFO - "product": "firefox", 17:44:03 INFO - "script_repo_revision": "production", 17:44:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:44:03 INFO - "repository": "", 17:44:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:44:03 INFO - "buildid": "20161111133014", 17:44:03 INFO - "pgo_build": "True", 17:44:03 INFO - "basedir": "/builds/slave/test", 17:44:03 INFO - "buildnumber": 183, 17:44:03 INFO - "slavename": "talos-linux64-ix-009", 17:44:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:44:03 INFO - "platform": "ubuntu64_hw", 17:44:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 17:44:03 INFO - "branch": "mozilla-central", 17:44:03 INFO - "repo_path": "mozilla-central", 17:44:03 INFO - "revision": "5d1c54f240d077b6b8e141fd44b52a3b694a5dfd", 17:44:03 INFO - "stage_platform": "linux64-pgo", 17:44:03 INFO - "builduid": "0511addcaf71485982a36c0b305aeafd", 17:44:03 INFO - "slavebuilddir": "test" 17:44:03 INFO - } 17:44:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:44:03 INFO - Running post-action listener: _resource_record_post_action 17:44:03 INFO - [mozharness: 2016-11-12 01:44:03.356645Z] Finished read-buildbot-config step (success) 17:44:03 INFO - [mozharness: 2016-11-12 01:44:03.356733Z] Running download-and-extract step. 17:44:03 INFO - Running pre-action listener: _resource_record_pre_action 17:44:03 INFO - Running main action method: download_and_extract 17:44:03 INFO - mkdir: /builds/slave/test/build/tests 17:44:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:03 INFO - trying https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:03 INFO - Downloading https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:44:03 INFO - Downloaded 1361 bytes. 17:44:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:03 INFO - Using the following test package requirements: 17:44:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:44:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:44:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:44:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'jsshell-linux-x86_64.zip'], 17:44:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:44:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:44:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:44:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:44:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:44:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:44:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:44:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:44:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:44:04 INFO - Http code: 200 17:44:04 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 17:44:04 INFO - x-amz-cf-id: JeTdtLAfTHy_ueziJmV4RF7JGpkkyCMNxyRuMvDncG5rzOw4LAB4vQ== 17:44:04 INFO - x-amz-version-id: OMdpCQzDFnQo0VwK7P_PoKn7kIEoWtFv 17:44:04 INFO - Expected file size: 21970375 17:44:04 INFO - Obtained file size: 21970375 17:44:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:44:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:44:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:44:09 INFO - Http code: 200 17:44:09 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 17:44:09 INFO - x-amz-cf-id: 67s6UIFSS3BVQdT_1Re-aZ10zjN7suFhWh-0lxMKQMGYQjJ0RdLZKA== 17:44:09 INFO - x-amz-version-id: OMdpCQzDFnQo0VwK7P_PoKn7kIEoWtFv 17:44:09 INFO - Expected file size: 21970375 17:44:09 INFO - Obtained file size: 21970375 17:44:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:44:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:44:14 INFO - Fetch https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:44:14 INFO - Http code: 200 17:44:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 17:44:14 INFO - x-amz-cf-id: 7dTo7EU7x_9EPOMJ9k-PM_QpkepAwtdu_8ZFtUKQdS-isc-rA8DlTQ== 17:44:14 INFO - x-amz-version-id: TT_Hrp3BtwR6AbIpU9HtuYyB49.ekap2 17:44:15 INFO - Expected file size: 14409038 17:44:15 INFO - Obtained file size: 14409038 17:44:15 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:15 INFO - trying https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:44:16 INFO - Downloaded 59380482 bytes. 17:44:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:16 INFO - mkdir: /builds/slave/test/properties 17:44:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:16 INFO - Contents: 17:44:16 INFO - build_url:https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:17 INFO - Running post-action listener: _resource_record_post_action 17:44:17 INFO - Running post-action listener: set_extra_try_arguments 17:44:17 INFO - [mozharness: 2016-11-12 01:44:17.587240Z] Finished download-and-extract step (success) 17:44:17 INFO - [mozharness: 2016-11-12 01:44:17.587466Z] Running populate-webroot step. 17:44:17 INFO - Running pre-action listener: _resource_record_pre_action 17:44:17 INFO - Running main action method: populate_webroot 17:44:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:17 INFO - '--tppagecycles', 17:44:17 INFO - '7'], 17:44:17 INFO - 'tests': ['tsvgm']}}, 17:44:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['damp', 'tps']}, 17:44:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'tests': ['damp', 'tps']}, 17:44:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['dromaeo_dom']}, 17:44:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['basic_compositor_video']}, 17:44:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:44:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['a11yr', 17:44:17 INFO - 'ts_paint', 17:44:17 INFO - 'tpaint', 17:44:17 INFO - 'sessionrestore', 17:44:17 INFO - 'sessionrestore_no_auto_restore', 17:44:17 INFO - 'tabpaint']}, 17:44:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['tsvgx', 17:44:17 INFO - 'tsvgr_opacity', 17:44:17 INFO - 'tart', 17:44:17 INFO - 'tscrollx', 17:44:17 INFO - 'cart']}, 17:44:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:17 INFO - 'tsvgr_opacity', 17:44:17 INFO - 'tart', 17:44:17 INFO - 'tscrollx', 17:44:17 INFO - 'cart']}, 17:44:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'talos_options': ['--disable-e10s'], 17:44:17 INFO - 'tests': ['tp5o']}, 17:44:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'tests': ['tp5o']}, 17:44:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'talos_options': ['--disable-e10s', 17:44:17 INFO - '--xperf_path', 17:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:17 INFO - 'tests': ['tp5n']}, 17:44:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:17 INFO - 'talos_options': ['--xperf_path', 17:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:17 INFO - 'tests': ['tp5n']}}, 17:44:17 INFO - 'talos.zip': {'path': '', 17:44:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:17 INFO - Running post-action listener: _resource_record_post_action 17:44:17 INFO - [mozharness: 2016-11-12 01:44:17.607040Z] Finished populate-webroot step (success) 17:44:17 INFO - [mozharness: 2016-11-12 01:44:17.607127Z] Running create-virtualenv step. 17:44:17 INFO - Running pre-action listener: _resource_record_pre_action 17:44:17 INFO - Running main action method: create_virtualenv 17:44:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:17 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 17:44:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:17 INFO - Using real prefix '/usr' 17:44:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:20 INFO - Installing pip.................done. 17:44:20 INFO - Return code: 0 17:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:44:20 INFO - Reading from file tmpfile_stdout 17:44:20 INFO - Output received: 17:44:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:20 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:20 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 17:44:20 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 17:44:20 INFO - Using env: {'DISPLAY': ':0', 17:44:20 INFO - 'HOME': '/home/cltbld', 17:44:20 INFO - 'LANG': 'en_US.UTF-8', 17:44:20 INFO - 'LANGUAGE': 'en_US:en', 17:44:20 INFO - 'LOGNAME': 'cltbld', 17:44:20 INFO - 'MAIL': '/var/mail/cltbld', 17:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:20 INFO - 'MOZ_NO_REMOTE': '1', 17:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:20 INFO - 'NO_EM_RESTART': '1', 17:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:20 INFO - 'PWD': '/builds/slave/test', 17:44:20 INFO - 'SHELL': '/bin/bash', 17:44:20 INFO - 'SHLVL': '1', 17:44:20 INFO - 'TERM': 'linux', 17:44:20 INFO - 'TMOUT': '86400', 17:44:20 INFO - 'USER': 'cltbld', 17:44:20 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:20 INFO - '_': '/tools/buildbot/bin/python'} 17:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:20 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 17:44:20 INFO - Cleaning up... 17:44:20 INFO - Return code: 0 17:44:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:20 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:20 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 17:44:20 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 17:44:20 INFO - Using env: {'DISPLAY': ':0', 17:44:20 INFO - 'HOME': '/home/cltbld', 17:44:20 INFO - 'LANG': 'en_US.UTF-8', 17:44:20 INFO - 'LANGUAGE': 'en_US:en', 17:44:20 INFO - 'LOGNAME': 'cltbld', 17:44:20 INFO - 'MAIL': '/var/mail/cltbld', 17:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:20 INFO - 'MOZ_NO_REMOTE': '1', 17:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:20 INFO - 'NO_EM_RESTART': '1', 17:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:20 INFO - 'PWD': '/builds/slave/test', 17:44:20 INFO - 'SHELL': '/bin/bash', 17:44:20 INFO - 'SHLVL': '1', 17:44:20 INFO - 'TERM': 'linux', 17:44:20 INFO - 'TMOUT': '86400', 17:44:20 INFO - 'USER': 'cltbld', 17:44:20 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:20 INFO - '_': '/tools/buildbot/bin/python'} 17:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:20 INFO - Downloading/unpacking psutil>=3.1.1 17:44:20 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 17:44:20 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 17:44:20 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 17:44:20 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 17:44:20 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 17:44:20 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 17:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:44:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:22 INFO - Installing collected packages: psutil 17:44:22 INFO - Running setup.py install for psutil 17:44:22 INFO - building 'psutil._psutil_linux' extension 17:44:22 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 17:44:23 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 17:44:23 INFO - building 'psutil._psutil_posix' extension 17:44:23 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 17:44:23 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 17:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:23 INFO - Successfully installed psutil 17:44:23 INFO - Cleaning up... 17:44:23 INFO - Return code: 0 17:44:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:23 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:23 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 17:44:23 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 17:44:23 INFO - Using env: {'DISPLAY': ':0', 17:44:23 INFO - 'HOME': '/home/cltbld', 17:44:23 INFO - 'LANG': 'en_US.UTF-8', 17:44:23 INFO - 'LANGUAGE': 'en_US:en', 17:44:23 INFO - 'LOGNAME': 'cltbld', 17:44:23 INFO - 'MAIL': '/var/mail/cltbld', 17:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:23 INFO - 'MOZ_NO_REMOTE': '1', 17:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:23 INFO - 'NO_EM_RESTART': '1', 17:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:23 INFO - 'PWD': '/builds/slave/test', 17:44:23 INFO - 'SHELL': '/bin/bash', 17:44:23 INFO - 'SHLVL': '1', 17:44:23 INFO - 'TERM': 'linux', 17:44:23 INFO - 'TMOUT': '86400', 17:44:23 INFO - 'USER': 'cltbld', 17:44:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:23 INFO - '_': '/tools/buildbot/bin/python'} 17:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:44:23 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 17:44:23 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 17:44:23 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 17:44:23 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 17:44:23 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 17:44:23 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 17:44:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:44:25 INFO - Installing collected packages: mozsystemmonitor 17:44:25 INFO - Running setup.py install for mozsystemmonitor 17:44:25 INFO - Successfully installed mozsystemmonitor 17:44:25 INFO - Cleaning up... 17:44:25 INFO - Return code: 0 17:44:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:44:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:25 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:25 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 17:44:25 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 17:44:25 INFO - Using env: {'DISPLAY': ':0', 17:44:25 INFO - 'HOME': '/home/cltbld', 17:44:25 INFO - 'LANG': 'en_US.UTF-8', 17:44:25 INFO - 'LANGUAGE': 'en_US:en', 17:44:25 INFO - 'LOGNAME': 'cltbld', 17:44:25 INFO - 'MAIL': '/var/mail/cltbld', 17:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:25 INFO - 'MOZ_NO_REMOTE': '1', 17:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:25 INFO - 'NO_EM_RESTART': '1', 17:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:25 INFO - 'PWD': '/builds/slave/test', 17:44:25 INFO - 'SHELL': '/bin/bash', 17:44:25 INFO - 'SHLVL': '1', 17:44:25 INFO - 'TERM': 'linux', 17:44:25 INFO - 'TMOUT': '86400', 17:44:25 INFO - 'USER': 'cltbld', 17:44:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:25 INFO - '_': '/tools/buildbot/bin/python'} 17:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:26 INFO - Downloading/unpacking jsonschema==2.5.1 17:44:26 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 17:44:26 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 17:44:26 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 17:44:26 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 17:44:26 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 17:44:26 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 17:44:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:44:27 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 17:44:27 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 17:44:27 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 17:44:27 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 17:44:27 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 17:44:27 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 17:44:28 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:28 INFO - warning: no files found matching '*.txt' 17:44:28 INFO - no previously-included directories found matching 'build' 17:44:28 INFO - no previously-included directories found matching 'dist' 17:44:28 INFO - no previously-included directories found matching '.git*' 17:44:28 INFO - Installing collected packages: jsonschema, functools32 17:44:28 INFO - Running setup.py install for functools32 17:44:28 INFO - warning: no files found matching '*.txt' 17:44:28 INFO - no previously-included directories found matching 'build' 17:44:28 INFO - no previously-included directories found matching 'dist' 17:44:28 INFO - no previously-included directories found matching '.git*' 17:44:28 INFO - Successfully installed jsonschema functools32 17:44:28 INFO - Cleaning up... 17:44:28 INFO - Return code: 0 17:44:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:28 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:44:28 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 functools32==3.2.3-2 17:44:28 INFO - Using env: {'DISPLAY': ':0', 17:44:28 INFO - 'HOME': '/home/cltbld', 17:44:28 INFO - 'LANG': 'en_US.UTF-8', 17:44:28 INFO - 'LANGUAGE': 'en_US:en', 17:44:28 INFO - 'LOGNAME': 'cltbld', 17:44:28 INFO - 'MAIL': '/var/mail/cltbld', 17:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:28 INFO - 'MOZ_NO_REMOTE': '1', 17:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:28 INFO - 'NO_EM_RESTART': '1', 17:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:28 INFO - 'PWD': '/builds/slave/test', 17:44:28 INFO - 'SHELL': '/bin/bash', 17:44:28 INFO - 'SHLVL': '1', 17:44:28 INFO - 'TERM': 'linux', 17:44:28 INFO - 'TMOUT': '86400', 17:44:28 INFO - 'USER': 'cltbld', 17:44:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:28 INFO - '_': '/tools/buildbot/bin/python'} 17:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:44:28 INFO - Cleaning up... 17:44:28 INFO - Return code: 0 17:44:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:28 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 17:44:28 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 17:44:28 INFO - Using env: {'DISPLAY': ':0', 17:44:28 INFO - 'HOME': '/home/cltbld', 17:44:28 INFO - 'LANG': 'en_US.UTF-8', 17:44:28 INFO - 'LANGUAGE': 'en_US:en', 17:44:28 INFO - 'LOGNAME': 'cltbld', 17:44:28 INFO - 'MAIL': '/var/mail/cltbld', 17:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:28 INFO - 'MOZ_NO_REMOTE': '1', 17:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:28 INFO - 'NO_EM_RESTART': '1', 17:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:28 INFO - 'PWD': '/builds/slave/test', 17:44:28 INFO - 'SHELL': '/bin/bash', 17:44:28 INFO - 'SHLVL': '1', 17:44:28 INFO - 'TERM': 'linux', 17:44:28 INFO - 'TMOUT': '86400', 17:44:28 INFO - 'USER': 'cltbld', 17:44:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:28 INFO - '_': '/tools/buildbot/bin/python'} 17:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:30 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 INFO - Downloading docopt-0.6.1.tar.gz 17:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:31 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:31 INFO - Running setup.py install for blobuploader 17:44:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:31 INFO - Running setup.py install for requests 17:44:31 INFO - Running setup.py install for docopt 17:44:32 INFO - Successfully installed blobuploader requests docopt 17:44:32 INFO - Cleaning up... 17:44:32 INFO - Return code: 0 17:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:32 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:32 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 17:44:32 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 17:44:32 INFO - Using env: {'DISPLAY': ':0', 17:44:32 INFO - 'HOME': '/home/cltbld', 17:44:32 INFO - 'LANG': 'en_US.UTF-8', 17:44:32 INFO - 'LANGUAGE': 'en_US:en', 17:44:32 INFO - 'LOGNAME': 'cltbld', 17:44:32 INFO - 'MAIL': '/var/mail/cltbld', 17:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:32 INFO - 'MOZ_NO_REMOTE': '1', 17:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:32 INFO - 'NO_EM_RESTART': '1', 17:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:32 INFO - 'PWD': '/builds/slave/test', 17:44:32 INFO - 'SHELL': '/bin/bash', 17:44:32 INFO - 'SHLVL': '1', 17:44:32 INFO - 'TERM': 'linux', 17:44:32 INFO - 'TMOUT': '86400', 17:44:32 INFO - 'USER': 'cltbld', 17:44:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:32 INFO - '_': '/tools/buildbot/bin/python'} 17:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:32 INFO - Running setup.py (path:/tmp/pip-u_OERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:32 INFO - Running setup.py (path:/tmp/pip-PIuA9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:32 INFO - Running setup.py (path:/tmp/pip-x34p79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:32 INFO - Running setup.py (path:/tmp/pip-PMe_nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:32 INFO - Running setup.py (path:/tmp/pip-71OENF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:32 INFO - Running setup.py (path:/tmp/pip-wx4Fio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:32 INFO - Running setup.py (path:/tmp/pip-7f3Cyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:32 INFO - Running setup.py (path:/tmp/pip-3QqUbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:32 INFO - Running setup.py (path:/tmp/pip-yv4NCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:32 INFO - Running setup.py (path:/tmp/pip-OeDLfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:33 INFO - Running setup.py (path:/tmp/pip-nsO8KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:33 INFO - Running setup.py (path:/tmp/pip-Ut6cWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:33 INFO - Running setup.py (path:/tmp/pip-AgYqA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:33 INFO - Running setup.py (path:/tmp/pip-HsQhPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:33 INFO - Running setup.py (path:/tmp/pip-2CRKDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:33 INFO - Running setup.py (path:/tmp/pip-TLC2sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:33 INFO - Running setup.py (path:/tmp/pip-KFCoqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:33 INFO - Running setup.py install for manifestparser 17:44:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:33 INFO - Running setup.py install for mozcrash 17:44:33 INFO - Running setup.py install for mozdebug 17:44:33 INFO - Running setup.py install for mozdevice 17:44:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:33 INFO - Running setup.py install for mozfile 17:44:34 INFO - Running setup.py install for mozhttpd 17:44:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for mozinfo 17:44:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for mozInstall 17:44:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for mozleak 17:44:34 INFO - Running setup.py install for mozlog 17:44:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for moznetwork 17:44:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for mozprocess 17:44:34 INFO - Running setup.py install for mozprofile 17:44:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:34 INFO - Running setup.py install for mozrunner 17:44:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:35 INFO - Running setup.py install for mozscreenshot 17:44:35 INFO - Running setup.py install for moztest 17:44:35 INFO - Running setup.py install for mozversion 17:44:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:35 INFO - Cleaning up... 17:44:35 INFO - Return code: 0 17:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:35 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:35 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 17:44:35 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 17:44:35 INFO - Using env: {'DISPLAY': ':0', 17:44:35 INFO - 'HOME': '/home/cltbld', 17:44:35 INFO - 'LANG': 'en_US.UTF-8', 17:44:35 INFO - 'LANGUAGE': 'en_US:en', 17:44:35 INFO - 'LOGNAME': 'cltbld', 17:44:35 INFO - 'MAIL': '/var/mail/cltbld', 17:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:35 INFO - 'MOZ_NO_REMOTE': '1', 17:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:35 INFO - 'NO_EM_RESTART': '1', 17:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:35 INFO - 'PWD': '/builds/slave/test', 17:44:35 INFO - 'SHELL': '/bin/bash', 17:44:35 INFO - 'SHLVL': '1', 17:44:35 INFO - 'TERM': 'linux', 17:44:35 INFO - 'TMOUT': '86400', 17:44:35 INFO - 'USER': 'cltbld', 17:44:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:35 INFO - '_': '/tools/buildbot/bin/python'} 17:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:35 INFO - Running setup.py (path:/tmp/pip-4oWQ11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:35 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)) 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:35 INFO - Running setup.py (path:/tmp/pip-5wprvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:35 INFO - Running setup.py (path:/tmp/pip-nxOvY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:35 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)) 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:35 INFO - Running setup.py (path:/tmp/pip-DO2y_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:35 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)) 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:35 INFO - Running setup.py (path:/tmp/pip-yLGhTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:35 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)) 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:35 INFO - Running setup.py (path:/tmp/pip-Tz7S01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:36 INFO - Running setup.py (path:/tmp/pip-KJmq66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:36 INFO - Running setup.py (path:/tmp/pip-oE3Ku5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:36 INFO - Running setup.py (path:/tmp/pip-MCK9GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:36 INFO - Running setup.py (path:/tmp/pip-rG2lEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:36 INFO - Running setup.py (path:/tmp/pip-pijlM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:36 INFO - Running setup.py (path:/tmp/pip-TlNAY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:36 INFO - Running setup.py (path:/tmp/pip-De5UGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:36 INFO - Running setup.py (path:/tmp/pip-SQ8TqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:36 INFO - Running setup.py (path:/tmp/pip-QAMj6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:36 INFO - Running setup.py (path:/tmp/pip-t0zQaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:36 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)) 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:36 INFO - Running setup.py (path:/tmp/pip-ItLw4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:36 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)) 17:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:36 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)) 17:44:36 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)) 17:44:36 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)) 17:44:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:38 INFO - Downloading blessings-1.6.tar.gz 17:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:38 INFO - Installing collected packages: blessings 17:44:38 INFO - Running setup.py install for blessings 17:44:38 INFO - Successfully installed blessings 17:44:38 INFO - Cleaning up... 17:44:38 INFO - Return code: 0 17:44:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:39 INFO - Reading from file tmpfile_stdout 17:44:39 INFO - Current package versions: 17:44:39 INFO - argparse == 1.2.1 17:44:39 INFO - blessings == 1.6 17:44:39 INFO - blobuploader == 1.2.4 17:44:39 INFO - docopt == 0.6.1 17:44:39 INFO - functools32 == 3.2.3-2 17:44:39 INFO - jsonschema == 2.5.1 17:44:39 INFO - manifestparser == 1.1 17:44:39 INFO - mozInstall == 1.12 17:44:39 INFO - mozcrash == 1.0 17:44:39 INFO - mozdebug == 0.1 17:44:39 INFO - mozdevice == 0.48 17:44:39 INFO - mozfile == 1.2 17:44:39 INFO - mozhttpd == 0.7 17:44:39 INFO - mozinfo == 0.9 17:44:39 INFO - mozleak == 0.1 17:44:39 INFO - mozlog == 3.4 17:44:39 INFO - moznetwork == 0.27 17:44:39 INFO - mozprocess == 0.23 17:44:39 INFO - mozprofile == 0.28 17:44:39 INFO - mozrunner == 6.13 17:44:39 INFO - mozscreenshot == 0.1 17:44:39 INFO - mozsystemmonitor == 0.3 17:44:39 INFO - moztest == 0.7 17:44:39 INFO - mozversion == 1.4 17:44:39 INFO - psutil == 3.1.1 17:44:39 INFO - requests == 1.2.3 17:44:39 INFO - wsgiref == 0.1.2 17:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 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 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:39 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 17:44:39 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 17:44:39 INFO - Using env: {'DISPLAY': ':0', 17:44:39 INFO - 'HOME': '/home/cltbld', 17:44:39 INFO - 'LANG': 'en_US.UTF-8', 17:44:39 INFO - 'LANGUAGE': 'en_US:en', 17:44:39 INFO - 'LOGNAME': 'cltbld', 17:44:39 INFO - 'MAIL': '/var/mail/cltbld', 17:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:39 INFO - 'MOZ_NO_REMOTE': '1', 17:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:39 INFO - 'NO_EM_RESTART': '1', 17:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:39 INFO - 'PWD': '/builds/slave/test', 17:44:39 INFO - 'SHELL': '/bin/bash', 17:44:39 INFO - 'SHLVL': '1', 17:44:39 INFO - 'TERM': 'linux', 17:44:39 INFO - 'TMOUT': '86400', 17:44:39 INFO - 'USER': 'cltbld', 17:44:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:39 INFO - '_': '/tools/buildbot/bin/python'} 17:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 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)) 17:44:39 INFO - Cleaning up... 17:44:39 INFO - Return code: 0 17:44:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47c3050f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, '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': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', '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 17:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:39 INFO - Using env: {'DISPLAY': ':0', 17:44:39 INFO - 'HOME': '/home/cltbld', 17:44:39 INFO - 'LANG': 'en_US.UTF-8', 17:44:39 INFO - 'LANGUAGE': 'en_US:en', 17:44:39 INFO - 'LOGNAME': 'cltbld', 17:44:39 INFO - 'MAIL': '/var/mail/cltbld', 17:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:39 INFO - 'MOZ_NO_REMOTE': '1', 17:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:39 INFO - 'NO_EM_RESTART': '1', 17:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:39 INFO - 'PWD': '/builds/slave/test', 17:44:39 INFO - 'SHELL': '/bin/bash', 17:44:39 INFO - 'SHLVL': '1', 17:44:39 INFO - 'TERM': 'linux', 17:44:39 INFO - 'TMOUT': '86400', 17:44:39 INFO - 'USER': 'cltbld', 17:44:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:39 INFO - '_': '/tools/buildbot/bin/python'} 17:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:39 INFO - Cleaning up... 17:44:39 INFO - Return code: 0 17:44:39 INFO - Running post-action listener: _resource_record_post_action 17:44:39 INFO - Running post-action listener: _start_resource_monitoring 17:44:39 INFO - Starting resource monitoring. 17:44:39 INFO - [mozharness: 2016-11-12 01:44:39.704945Z] Finished create-virtualenv step (success) 17:44:39 INFO - [mozharness: 2016-11-12 01:44:39.705590Z] Running install step. 17:44:39 INFO - Running pre-action listener: _resource_record_pre_action 17:44:39 INFO - Running main action method: install 17:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:39 INFO - Reading from file tmpfile_stdout 17:44:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:39 INFO - Reading from file tmpfile_stdout 17:44:39 INFO - Output received: 17:44:39 INFO - Usage: mozinstall [options] installer 17:44:39 INFO - Options: 17:44:39 INFO - -h, --help show this help message and exit 17:44:39 INFO - -d DEST, --destination=DEST 17:44:39 INFO - Directory to install application into. [default: 17:44:39 INFO - "/builds/slave/test"] 17:44:39 INFO - --app=APP Application being installed. [default: firefox] 17:44:39 INFO - mkdir: /builds/slave/test/build/application 17:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:44:56 INFO - Reading from file tmpfile_stdout 17:44:56 INFO - Output received: 17:44:56 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:56 INFO - Running post-action listener: _resource_record_post_action 17:44:56 INFO - [mozharness: 2016-11-12 01:44:56.877443Z] Finished install step (success) 17:44:56 INFO - [mozharness: 2016-11-12 01:44:56.877693Z] Running run-tests step. 17:44:56 INFO - Running pre-action listener: _resource_record_pre_action 17:44:56 INFO - Running main action method: run_tests 17:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:56 INFO - Python 2.7.3 17:44:56 INFO - Return code: 0 17:44:56 INFO - grabbing minidump binary from tooltool 17:44:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:56 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 0x11e3790>, '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 0x11e4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:56 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 17:44:56 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 17:44:56 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 17:44:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:56 INFO - Return code: 0 17:44:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:44:56 INFO - Using env: {'DISPLAY': ':0', 17:44:56 INFO - 'HOME': '/home/cltbld', 17:44:56 INFO - 'LANG': 'en_US.UTF-8', 17:44:56 INFO - 'LANGUAGE': 'en_US:en', 17:44:56 INFO - 'LOGNAME': 'cltbld', 17:44:56 INFO - 'MAIL': '/var/mail/cltbld', 17:44:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:56 INFO - 'MOZ_NO_REMOTE': '1', 17:44:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:56 INFO - 'NO_EM_RESTART': '1', 17:44:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:56 INFO - 'PWD': '/builds/slave/test', 17:44:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:56 INFO - 'SHELL': '/bin/bash', 17:44:56 INFO - 'SHLVL': '1', 17:44:56 INFO - 'TERM': 'linux', 17:44:56 INFO - 'TMOUT': '86400', 17:44:56 INFO - 'USER': 'cltbld', 17:44:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444', 17:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:56 INFO - '_': '/tools/buildbot/bin/python'} 17:44:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:44:57 INFO - mozversion application_buildid: 20161111133014 17:44:57 INFO - mozversion application_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 17:44:57 INFO - mozversion application_display_name: Nightly 17:44:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:57 INFO - mozversion application_name: Firefox 17:44:57 INFO - mozversion application_remotingname: firefox 17:44:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:44:57 INFO - mozversion application_vendor: Mozilla 17:44:57 INFO - mozversion application_version: 52.0a1 17:44:57 INFO - mozversion platform_buildid: 20161111133014 17:44:57 INFO - mozversion platform_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 17:44:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:44:57 INFO - mozversion platform_version: 52.0a1 17:44:57 INFO - using testdate: 1478915097 17:44:57 INFO - actual date: 1478915097 17:44:57 INFO - starting webserver on 'localhost:37353' 17:44:57 INFO - SUITE-START | Running 2 tests 17:44:57 INFO - TEST-START | dromaeo_css 17:44:57 INFO - operating with platform_type : linux_ 17:44:57 INFO - Initialising browser for dromaeo_css test... 17:44:57 INFO - TEST-INFO | started process 27209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zna52/profile http://localhost:37353/getInfo.html) 17:45:01 INFO - PROCESS | 27209 | __metrics Screen width/height:1600/1200 17:45:01 INFO - PROCESS | 27209 | colorDepth:24 17:45:01 INFO - PROCESS | 27209 | Browser inner width/height: 1024/697 17:45:01 INFO - PROCESS | 27209 | __metrics 17:45:02 ERROR - PROCESS | 27209 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3174: TypeError: this.tabs is undefined 17:45:03 INFO - TEST-INFO | 27209: exit 0 17:45:03 INFO - Browser initialized. 17:45:03 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:03 INFO - TEST-INFO | started process 27331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zna52/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:15 INFO - PROCESS | 27331 | RSS: Main: 185290752 17:45:15 INFO - PROCESS | 27331 | 17:46:04 INFO - PROCESS | 27331 | 1478915164968 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] 17:48:16 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37353/tests/dromaeo/cssquery-ext.html) 17:48:18 INFO - PROCESS | 27331 | RSS: Main: 197074944 17:48:18 INFO - PROCESS | 27331 | 17:51:20 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-ext.html (next: http://localhost:37353/tests/dromaeo/cssquery-jquery.html) 17:51:20 INFO - PROCESS | 27331 | RSS: Main: 196874240 17:51:20 INFO - PROCESS | 27331 | 17:54:23 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37353/tests/dromaeo/cssquery-mootools.html) 17:54:23 INFO - PROCESS | 27331 | RSS: Main: 198656000 17:54:23 INFO - PROCESS | 27331 | 17:57:25 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37353/tests/dromaeo/cssquery-prototype.html) 17:57:26 INFO - PROCESS | 27331 | RSS: Main: 195362816 17:57:26 INFO - PROCESS | 27331 | 18:00:28 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37353/tests/dromaeo/cssquery-yui.html) 18:00:29 INFO - PROCESS | 27331 | RSS: Main: 198733824 18:00:29 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | Cycle 1(1): loaded http://localhost:37353/tests/dromaeo/cssquery-yui.html (next: http://localhost:37353/tests/dromaeo/cssquery-dojo.html) 18:03:32 INFO - PROCESS | 27331 | RSS: Main: 198864896 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | __start_tp_report 18:03:32 INFO - PROCESS | 27331 | _x_x_mozilla_page_load 18:03:32 INFO - PROCESS | 27331 | _x_x_mozilla_page_load_details 18:03:32 INFO - PROCESS | 27331 | |i|pagename|runs| 18:03:32 INFO - PROCESS | 27331 | |0;dojo.html;2980.672126066133;2989.073387249954;3025.152957171991;3025.6671766105724;3028.6971302869715;5239.842804715855;5265.315508983832;5334.333208348961;5339.786408543659;5392.514673679368;5316.7873285068645;5344.839654810362;5369.167778994262;5371.4897084776985;5374.462553744624;4829.855104346866;4909.263610458442;4935.259711043336;4953.727544985024;4983.327250821148;4922.433920099181;4956.058348913695;4995;4996;5043.268726034723;4880.926786098212;4970.030843985424;5015.247712843066;5021.698698078127;5026.29631851541;4733.077049975256;4954.529319714621;4958.677685950438;5015.949840501585;5036.7733451994745;4760.214564596838;4811.254255590389;4816;4819.879503012417;4821.927671084936;5218.712970786605;5229.581633469314;5275.103232450492;5278.498542638443;5285.339332583427;5632.436756324376;5663.830085097413;5705.914411283834;5711.371749107595;5752.050911599581;5808.82573522795;5808.82573522795;5812.186293918855;5818.0981947798155;5834.912476312858;5321.760520776575;5364.061289274361;5420.159875219387;5428.131498960187;5435.320584926884;5820.941790582125;5864.9413505864395;5873.442023007808;5874.206982057453;5911.054231322968;5621.606487545832;5628.352739434936;5652.830415087554;5655.915161272585;5674.602777805597;5582.86042848932;5604.85987850307;5611.466910643482;5661.688607126565;5706.201131841545;5519.061759500894;5616.775328986876;5660.8867822643315;5661.745221465044;5688.175214593861;5502.504774570308;5534.142207957773;5660.066089095336;5756.136579513023;5799.536037117105;4427.649566882067;4438.778061096932;4470.240059189946;4475.686701930898;4489.32660100981;3921.8039098044983;3932.744371615836;3949.585293544194;3962.6037396260144;4025.094353770437;5401.432849550819;5442.510174084351;5447.945520544823;5463.972680136653;5551.2228288039705;5666.433356664301;5695.515881150149;5732.598718089694;5743.85640358986;5824.359320474744;5518.227448157261;5534.1145416733125;5536.695481748462;5543.2793736814765;5555.583331250173;4920.335754673145;4924.3105965164905;4929.408470983505;4940.086084074458;4984.177610694195;5840.3575606683235;5903.970480147572;5904.704764761745;5937.465628093492;5978.850528736816;5748.597598168088;5761;5772.249607550992;5808.854778630568;5808.883822323614;5927.7036148191555;6027.60820546663;6030.517558595389;6035.155078288955;6065.696715164136;5586.720663966867;5647.491725744702;5681.801136960186;5686.687232202268;5692.715364231689;5747.051736463437;5749.8562535936935;5761.991651461061;5762.337331206965;5765.250517432874;5608.775648974159;5610.382857885547;5613;5617.157426386075;5617.915731263953;5579.581531385244;5606.85982850432;5607;5613.214150018919;5740.741666625096;5599.384067752625;5628.549716022627;5639.379668236573;5657;5676.9716151420635;5685;5689.089745640677;5698.088305871041;5717.313922329347;5724.084146536534;5414;5530.308711411074;5545.528630066489;5552.944470555242;5633.971830140823 18:03:32 INFO - PROCESS | 27331 | |1;ext.html;535.9517643412092;537.2937175905678;547.3568556945588;575.6891278709496;589.0633892111543;40456.19087618246;41741;41822.790886045565;44771.55228447715;44956;43076.35385469221;43243.3513497297;43427.56572434275;43551.56448435515;43551.56448435523;8485.406021578476;8668.913310866874;8676.392652514327;8676.436031657922;8730.563471826383;8559.400841941067;8638.04981452043;8656.740297791077;8658.047614762403;8668.783280417976;8216.548089855056;8223.794405139859;8248.958755206215;8278.296344810698;8305.916940830575;8684.956575217084;8718.912810871905;8733.650653973866;8760.386772925898;8765.912340876574;8353.707620233323;8458.87311690325;8476.152384761535;8479.745607631781;8482.406231563793;40719.38920916188;41275.174496510204;41439.585604143875;41468.37797433041;41473;3103.67411421802;3136.200268931431;3205.9038228853174;3346.9497957530657;3439.466882633196;30403.847980760176;30555.847220763753;30972.690273097207;31014.534781978287;32537.6746232537;3615.403458429356;3620.9366063507523;3645.9270814583824;3686.170611612366;3751.4372844073337;326328;326990;328320;328648;329273;57369;57486.7125664369;57527;57622;57716.42283577195;59465.70267148637;59715.70142149262;59902.70048649729;60057.399426005184;60163.39836601578;14456.494022709154;14608.415663373558;14634.780478292834;14649.707005859824;14706.63233419173;11586.073114150848;11669.474873630706;11681.415929203506;11709.414529273503;11732.41337933117;16971.830281697024;17498.300067997137;17630;17652.293908243526;17686.646267074586;5947.520700390233;6032.879342413127;6045.848853778691;6201.658908759971;6236.066819286036;890.3589415620743;984.1880448629909;1033.2973577967055;1124.0164855751218;1141.9429028548539;31176;31344.843275783474;31549.52675709866;32112.35775284528;32177.195570110933;1070.9357438553711;1088.9237753357347;1096.753230523126;1114.0419239454063;1138.9772204555863;16663.750043749355;17499.475015749547;17531.474055778348;18247.270109195484;18427.72358414625;491265;497492;500916;501368;501594;56081;56185.438145618835;56366.43633563612;56454.15318770222;56494.43505564974;1009.0918173643779;1063.9574417023387;1069.4385447640052;1070.384528895888;1229.9053842080555;24769;26225.868870655526;26833.865830670722;26859.194224173305;27031.72968270292;50194;51422;53856;54205.72897135647;59061;336385;337089;339313;339629;342329;40375.1924961505;41022.58977410307;41389.58610413857;41391.7930410346;42144.578554214066;46284.53715462802;46388.768056159504;47482.28776568285;47800.282995755784;48083.27875081806;30893.227669308446;31434.685653143177;31463.528047078853;31471.84264078665;32662;40363.19273614453;40450.797746011085;40693.38959915663;40820.59179408168;40853.79573102116;38378;39887;40022.59920902755;40568.79715601403;40672.79663601663;33350.49716796701;35685.46471802977;35696.64303356933;36727;36960.445593315584;27324.72675273222;27857.582136267567;28139;28237.43525129445;28244.576331355456 18:03:32 INFO - PROCESS | 27331 | |2;jquery.html;374.82383279858476;385.283372926357;386.11940151492746;395.1149425287357;417.96656267498605;18902.52743681407;19371.612567748638;19382;19448;19705.31031413901;17682;17698.823011769877;18116.4565063048;18294.81705182948;18505.537361565934;5427.158790387486;5437.238786569884;5678.233438485813;5680.687562184078;5742.827715168552;5793.768249270045;5801.274840644919;5819.039858423355;5829.0964900440285;5838.824835254949;5660.773569057233;5742.310922689262;5786.334571524287;5800.266231920897;5826.621269617462;5797.507211886974;5839.153322768218;5844.620099693528;5855.092460668582;5855.912161317584;5466.289382380305;5544.251526044013;5615.2700148980375;5628;5629.211910332557;13501.729965400637;13548.796768048487;13591.184528928197;13927.860721392859;14062;2287.1080278691325;2288.8054515366216;2302.3668491164894;2319.5824751544715;2804.102687140116;10075.868295432472;10236.232282578836;10676.199285053573;10767.407792571405;13565.050446468751;1858.8419984301352;1862.8230318119893;1867.8599105067174;1901.9904900475547;1938.0116140768168;77815.6109219456;78498.60750696267;78575;79329.60335198345;81755.59122204351;10270;10352.741181470374;10436.582536698446;10461;10495.317804342692;13817.065610814494;13832.723345533033;13888.305584720723;14027.438902443992;14204;7545.622718864035;7563.546187228784;7663.157052724196;7707.730229441942;7724.961375193088;7152.964235178791;7302.05073340473;7310.890336644955;7441.665125069277;7505.924940750632;4209.305464598368;4226.344916537942;4283.336082907154;4304.439451383227;4408.360787685831;1973.7236786849853;1974.7926467720683;2011.9195232190548;2017.6569983102909;2034.3591768592846;849.6856163219649;954.370115723619;979.686500319905;996.9551370188359;1022.7801022779989;18089.366872159673;18974.62050758977;19448.319308824124;19843.107060182327;20064.39806805769;978.2272005116021;1008.9949550252202;1009.7172791618211;1040.47976011994;1057.6509751781894;10304.845427318596;10869.67390978272;10993.120550355952;11002.284851484628;11035.282706624044;406129;407576;410380;410673;411597;86287;88206.55896720475;93910.11886346259;94865.52567237258;101191;950.0736781637847;975.1370037516849;979.2019504104275;983.1888691829126;985.4284514981293;16548.255328510004;17843.286268549113;18103.456896293133;18234.635307294044;18360.63278734391;43024.56975430331;43351.34972975345;43631.12737745291;43975.68072957816;45181.096378072914;59219.407805921386;59931;60048.39951600603;61575.384246156966;61634;8214.26071653554;8412.369072319723;8505.91494085076;8626;8878.245349145394;11851.170418070653;13389.799153012518;13449.529266475627;13796.793048104086;13806.17162970225;11263.380514071478;11291.717707057389;11438.992705106293;11646.475908583965;11674.241174323643;10747.516361763583;10851.348919064882;10909.34543927367;11021.83467247976;11387.202895797214;11384.121619932619;11384.14618903569;11384.260023098472;11513;11756.58851940178;7374.631268436664;7501.137369202612;7733.149353570991;8140.308073813792;9045.276377889884;10639.308444951053;11563.537458501565;11627.53489860396;11632.651020469399;12285.815712764137 18:03:32 INFO - PROCESS | 27331 | |3;mootools.html;1466.7213229486397;1478.896477246593;1569.7096037233114;1694.8135705072432;1717.9656406871864;7194.784156475314;7453.881917712332;7692.884606730897;8127.512349259048;8186.099529051807;7531.849363012737;7758.379329653629;7767.106782719989;7953.483023603476;7990.960045199766;2245.9887700561476;2270.852394594346;2273.533925545259;2277.977220227793;2278.977210227901;2217.589745897006;2245.146844199202;2285.0402830811017;2286.0627142871426;2287.7597852225526;2229.3312006398096;2240.932772016842;2262.0386335807298;2262.8868556572106;2267.115824828318;2075.616011037963;2081.2923605973965;2094.4554415851835;2095.6646936490165;2096.0986775686447;2222;2240.6975058367075;2241.1707668162885;2243.14760391052;2248.482848944752;8035.799105022363;8039.95980020102;8083.878741818878;8091.797705057421;8111.351091912633;4961.950380496185;4990.90018199634;5071.492850714936;5085.74571271435;5087.872803179913;2981.403719256136;3117.9688203117908;3225.5000474926424;3311.6688331166933;3329.267561136546;1091.5142761471147;1106.9723256918642;1132.2300835431904;1142.53156205956;1158.1661203933154;11971.64085077449;12000.759984800343;12030.699232519257;12032.879671203264;12045.93977030118;4223.345381465878;4478.171538265431;4489.361383095147;4600.953990460052;4607.124646317189;9889.752756181153;9904.851427228597;9927.40435573868;9935.254855885838;9940.801183976424;5029.547340739277;5032.421271553745;5090.669106508065;5092.949070509321;5101.591872650179;4041.78746376086;4534.659900507475;4641.814327426932;4646.279826626878;4648.83729069481;3859.0931131184147;3867.497225360685;3898.493195884517;4000.6199411055904;4015.3374693175297;1302.5766625846638;1303.8565757766637;1313.2317594207495;1314.9013823963242;1320.966975825612;817.9222973817477;926.6386109417333;930.5254320296698;939.96710115147;961.7211008807508;5664.065429204135;5686.431356864363;5689.317281926195;5864.296284445893;5903.144044113579;437.7942367087464;443.58967954641827;447.8007286757427;449.40678304637566;449.4898290440374;3919.529656441245;3920.862769803043;3928;3935.4490371348033;3958.2083583282883;10112.696619101438;10425.478726063666;10437.843432348369;10462.843057354146;10516.894831051592;10304.227182961158;10343.27597068198;10355.741106472398;10379.065884070318;10400.895991040145;7300.452466065172;7462.96268518654;7518.360939320219;7519.360854327334;7532.096148462219;5462.235287059894;5501.339839219319;5538.196961440649;5607.383187849415;5754.56840736938;9403.43579385239;9404.905950940676;9431.57557909882;9489.66786162481;9662.9033709662;9434;9529.618815247313;9585.856212156683;9623.855642165234;9641.228701703987;7105.680244389118;7176.641167941686;7302.890456643261;7327.74352897646;7413.629318534159;8026;8036.075851277178;8067.717629882926;8081.313088387553;8086.87869681967;6854.5201835873;6972.4073453757;6985.231624521197;7001.929980700128;7070.787876363717;7165.534240274365;7184.820379490346;7248.855022899618;7347.7795666130105;7470.775876723707;6635.2037755469655;6741.696623651849;6758.121444212221;6761.864762704817;6766.086578311865;4903.828366007173;5014.974925125351;5073.34046573943;5180.248863914787;5244.292020577326;5020.774065167003;5048.5203905628905;5116.488351164854;5139.743012849417;5140.820071297487 18:03:32 INFO - PROCESS | 27331 | |4;prototype.html;318.8644825948971;321.6237002706833;334.52974178485556;334.84095054848945;338.0955942852868;5314.7314401643;5438;5467.316585426822;5470.699111548864;5479.945200547993;5294.835136270024;5335.919961200585;5338.759755810988;5371.194320851864;5371.454839805729;4211.599898009684;4236.279832428495;4241.830326786932;4246.214450326699;4255.553166917475;3931.6658084062888;4123.175364927027;4167.666586673074;4258.956555643872;4272.444582204309;4108.691848111389;4122.690798190133;4134.545200027995;4141.4202011718235;4150.211459822624;4118.176364727052;4130.6282434581035;4159.646430053464;4198.307279298942;4222.387753775716;3635.1820840310984;3695.7597756145765;3702.9259414811822;3721.5162028936065;3721.702263818888;5256.500632439912;5257.447967963385;5257.76340064698;5268.262443257909;5291.814786482455;4779.761011949424;4788.640851936118;4792.952070479286;4797.208460603996;4809.591184749301;5472.890542189174;5614.3543492498475;5636.436356364372;5638.4925356718095;5650.773969041234;3975.7813320267373;3986.5814089520472;4000.159966407058;4005.859794907164;4037.4347591337237;5764.308283006024;5823.737931793079;5826.242588463472;5833.7083145842535;5839.386864379221;3972.6424621784176;4116.444280022159;4117.526484454266;4118.361653943643;4131.318332475168;4115.71190016696;4147.108371700038;4151.6886233532005;4154.646855017358;4159.939215500028;4721.952780472151;4738.147133516;4758.666893317434;4765.880852978703;4776.498467660915;5395.460453954652;5658.519025882763;5667.773289068474;5677.233573467612;5683.658980461186;1388.5001399496173;1391.9095258808347;1396.441423430636;1399.5864177180918;1408.7532533707742;920.5259291464901;945.7824700318965;952.6522819171091;959.3620242538773;961.245422343457;5253.658512196695;5297.417284098746;5316.415194328621;5316.415194328621;5324.722066704041;5601.263608281446;5623.200575815781;5624.690642014729;5642.887142257132;5652.378238393773;5192.350956130484;5352.946470535323;5369.704666243316;5382.354117505846;5383.66212947967;2943.749781268616;2970.1980465274255;2984.8358340291493;2992.7156920092557;2996.925076873096;5798.681072540966;5824.271966004249;5826.650400975955;5838.562107841929;5895.081934442393;5414.729263536886;5594.804181853616;5628.943710562842;5638.35158956717;5691.686957217393;5809.3609702932645;5815.79644712433;5827.65034097964;5828;5837.241158649348;5563.193336966198;5594.41258667834;5595.817631123784;5607.943920560742;5859.677717725566;5783.450572195635;5803.47768700819;5809.82570522885;5811.912821307768;5834.299884013776;6086.478380404898;6100;6103.572749907464;6121.387861213843;6127.356627554221;3868.9806550967064;4056.9391459127546;4086.9578257544135;4090.734102283342;4092.856750013735;5661.716914154358;5824.737886795019;5838.970805145947;5839.1606643908735;5842.5325973921135;5669.433056694463;5734.283214598176;5734.741936612779;5738.598298119258;5745.9425405745405;5681.630694004876;5703.971480142573;5739.971300143473;5753.223314852608;5776.42235776419;5629.859253518531;5650.406707295675;5665.433456654467;5672.5461963042035;5694.4590263924865;5695.1457281406465;5702.258706368146;5711.914321285101;5717.914231286451;5744.913826292693;5463.399026107046;5540.119138048273;5599.60802743804;5617.775288988395;5624.887502250014 18:03:32 INFO - PROCESS | 27331 | |5;yui.html;539.6950722841594;577.5812535911463;607.1014897951032;686.8729285082262;695.3706895259788;12258.325792081432;12946.546870859522;13103.379324135176;13113.409896554655;13197.934010329935;12382.380880955961;12435.316057616827;12569.874301256985;12574.81137782934;12578.056645751582;497.8040976928112;502.96479246452765;773.4237992695436;781.4451739265129;783.3967844759532;757.2351924556183;779.9337056350217;791.2641243643409;791.5567282321919;791.6160662078887;842.3513894301384;843.8649816029437;844.7423535821572;846.4159729786459;847.3263755314509;836.5315423362936;838.3293365307729;841.5623875584693;843.3337663246028;843.4770442325766;604.0335463258795;608.6287364707525;609.2719200555338;611.2695329081749;613.6839527643267;12484.81272780909;12874.034447416387;12898.484060637564;12915.225086494747;12941;12574;12612.495500180074;12789.296588687619;12834.229946203164;12973.740525189443;9745.512724363753;9942.105210531086;10011;10022.398656080659;10061.238421254548;3239.303549736794;3272.525483804835;3296.620888597818;3305.636379998198;3318.5188147718686;60893;62932;63173.684131579044;63855.68072159656;64325.67837160831;9782.9021709782;9860.260480463994;9913.75215619601;10019.599216031276;10062.547185376676;16535.751963720555;16930.91534542344;17487.65024699499;17638.559036024202;17699;7286.453515986323;7306.123265208209;7450;7594.278543538355;7861.685532578747;4147.52303485097;4231.111466591989;4256.042390462183;4260.169266992907;4272.188284225987;3062.540618907182;3143.8899638512544;3149.653538110806;3154.542591324245;3245.6429792722784;560.1849309255024;561.7668667503023;562.7439713079773;563.943605639441;574;541.6371031408966;541.6831153775007;559.2924949938331;584.6433675457968;593.4658807073669;7941.841163176704;8602.569676616547;8794.008763033404;8822.86765698515;9005.909940900638;565.4854082784728;567.8410045187354;601.1703848688782;605.391581460638;624.7313655128338;3961.207758448322;4135.0902801383645;4200.788520104316;4247.469066366704;4329.458817647794;83473.58263208767;83573.58213208895;85338.57330713431;85704;90050.54974725084;49546;61187.694061530296;74677;76617.33826617294;76717.61641191758;68212.31787682159;69834;70526;71346.50861659554;72638;8044.758657240292;8104.554249516334;8360.749177524684;8374.827524146745;8554.358423118416;48185.27722084102;48616.75691621519;49316;49653.503464966336;50863.237051445;53581.46418535765;53619.19571206357;53998;59733;64492.355076448635;11022.448877556251;11145.609903653332;11388.601398951329;11511.19421640477;11613.419329033684;12591.748165036464;12642;13077.346132693518;13264.734705305647;13750.174989500661;11604.245724027911;11980.28118312904;12052;12649.87350126487;12939.611811645666;11499.885001149882;11661;12111.212771169845;12152.513899443924;12313.93843030815;11536.769264614828;11971.426143379214;12088.093392995384;12228.938855305667;12628.494860205856;9630;9805.362651427635;9998.500074996367;10338.224633152393;10711.596667148726;9376.156145946898;9573.32986690925;10299.227557933034;10412.47937603132;10507.842382364117 18:03:32 INFO - PROCESS | 27331 | __end_tp_report 18:03:32 INFO - PROCESS | 27331 | __start_cc_report 18:03:32 INFO - PROCESS | 27331 | _x_x_mozilla_cycle_collect,316 18:03:32 INFO - PROCESS | 27331 | __end_cc_report 18:03:32 INFO - PROCESS | 27331 | __startTimestamp1478916212647__endTimestamp 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | ------- Summary: start ------- 18:03:32 INFO - PROCESS | 27331 | Number of tests: 6 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#0] dojo.html Cycles:165 Average:5340.62 Median:5579.58 stddev:607.51 (10.9%) stddev-sans-first:580.48 18:03:32 INFO - PROCESS | 27331 | Values: 2980.7 2989.1 3025.2 3025.7 3028.7 5239.8 5265.3 5334.3 5339.8 5392.5 5316.8 5344.8 5369.2 5371.5 5374.5 4829.9 4909.3 4935.3 4953.7 4983.3 4922.4 4956.1 4995.0 4996.0 5043.3 4880.9 4970.0 5015.2 5021.7 5026.3 4733.1 4954.5 4958.7 5015.9 5036.8 4760.2 4811.3 4816.0 4819.9 4821.9 5218.7 5229.6 5275.1 5278.5 5285.3 5632.4 5663.8 5705.9 5711.4 5752.1 5808.8 5808.8 5812.2 5818.1 5834.9 5321.8 5364.1 5420.2 5428.1 5435.3 5820.9 5864.9 5873.4 5874.2 5911.1 5621.6 5628.4 5652.8 5655.9 5674.6 5582.9 5604.9 5611.5 5661.7 5706.2 5519.1 5616.8 5660.9 5661.7 5688.2 5502.5 5534.1 5660.1 5756.1 5799.5 4427.6 4438.8 4470.2 4475.7 4489.3 3921.8 3932.7 3949.6 3962.6 4025.1 5401.4 5442.5 5447.9 5464.0 5551.2 5666.4 5695.5 5732.6 5743.9 5824.4 5518.2 5534.1 5536.7 5543.3 5555.6 4920.3 4924.3 4929.4 4940.1 4984.2 5840.4 5904.0 5904.7 5937.5 5978.9 5748.6 5761.0 5772.2 5808.9 5808.9 5927.7 6027.6 6030.5 6035.2 6065.7 5586.7 5647.5 5681.8 5686.7 5692.7 5747.1 5749.9 5762.0 5762.3 5765.3 5608.8 5610.4 5613.0 5617.2 5617.9 5579.6 5606.9 5607.0 5613.2 5740.7 5599.4 5628.5 5639.4 5657.0 5677.0 5685.0 5689.1 5698.1 5717.3 5724.1 5414.0 5530.3 5545.5 5552.9 5634.0 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#1] ext.html Cycles:180 Average:55404.58 Median:40620.80 stddev:104791.67 (258.0%) stddev-sans-first:105004.66 18:03:32 INFO - PROCESS | 27331 | Values: 536.0 537.3 547.4 575.7 589.1 40456.2 41741.0 41822.8 44771.6 44956.0 43076.4 43243.4 43427.6 43551.6 43551.6 8485.4 8668.9 8676.4 8676.4 8730.6 8559.4 8638.0 8656.7 8658.0 8668.8 8216.5 8223.8 8249.0 8278.3 8305.9 8685.0 8718.9 8733.7 8760.4 8765.9 8353.7 8458.9 8476.2 8479.7 8482.4 40719.4 41275.2 41439.6 41468.4 41473.0 3103.7 3136.2 3205.9 3346.9 3439.5 30403.8 30555.8 30972.7 31014.5 32537.7 3615.4 3620.9 3645.9 3686.2 3751.4 326328.0 326990.0 328320.0 328648.0 329273.0 57369.0 57486.7 57527.0 57622.0 57716.4 59465.7 59715.7 59902.7 60057.4 60163.4 14456.5 14608.4 14634.8 14649.7 14706.6 11586.1 11669.5 11681.4 11709.4 11732.4 16971.8 17498.3 17630.0 17652.3 17686.6 5947.5 6032.9 6045.8 6201.7 6236.1 890.4 984.2 1033.3 1124.0 1141.9 31176.0 31344.8 31549.5 32112.4 32177.2 1070.9 1088.9 1096.8 1114.0 1139.0 16663.8 17499.5 17531.5 18247.3 18427.7 491265.0 497492.0 500916.0 501368.0 501594.0 56081.0 56185.4 56366.4 56454.2 56494.4 1009.1 1064.0 1069.4 1070.4 1229.9 24769.0 26225.9 26833.9 26859.2 27031.7 50194.0 51422.0 53856.0 54205.7 59061.0 336385.0 337089.0 339313.0 339629.0 342329.0 40375.2 41022.6 41389.6 41391.8 42144.6 46284.5 46388.8 47482.3 47800.3 48083.3 30893.2 31434.7 31463.5 31471.8 32662.0 40363.2 40450.8 40693.4 40820.6 40853.8 38378.0 39887.0 40022.6 40568.8 40672.8 33350.5 35685.5 35696.6 36727.0 36960.4 27324.7 27857.6 28139.0 28237.4 28244.6 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#2] jquery.html Cycles:180 Average:26469.52 Median:1589.46 stddev:68107.13 (4284.9%) stddev-sans-first:68270.00 18:03:32 INFO - PROCESS | 27331 | Values: 374.8 385.3 386.1 395.1 418.0 18902.5 19371.6 19382.0 19448.0 19705.3 17682.0 17698.8 18116.5 18294.8 18505.5 5427.2 5437.2 5678.2 5680.7 5742.8 5793.8 5801.3 5819.0 5829.1 5838.8 5660.8 5742.3 5786.3 5800.3 5826.6 5797.5 5839.2 5844.6 5855.1 5855.9 5466.3 5544.3 5615.3 5628.0 5629.2 13501.7 13548.8 13591.2 13927.9 14062.0 2287.1 2288.8 2302.4 2319.6 2804.1 10075.9 10236.2 10676.2 10767.4 13565.1 1858.8 1862.8 1867.9 1902.0 1938.0 77815.6 78498.6 78575.0 79329.6 81755.6 10270.0 10352.7 10436.6 10461.0 10495.3 13817.1 13832.7 13888.3 14027.4 14204.0 7545.6 7563.5 7663.2 7707.7 7725.0 7153.0 7302.1 7310.9 7441.7 7505.9 4209.3 4226.3 4283.3 4304.4 4408.4 1973.7 1974.8 2011.9 2017.7 2034.4 849.7 954.4 979.7 997.0 1022.8 18089.4 18974.6 19448.3 19843.1 20064.4 978.2 1009.0 1009.7 1040.5 1057.7 10304.8 10869.7 10993.1 11002.3 11035.3 406129.0 407576.0 410380.0 410673.0 411597.0 86287.0 88206.6 93910.1 94865.5 101191.0 950.1 975.1 979.2 983.2 985.4 16548.3 17843.3 18103.5 18234.6 18360.6 43024.6 43351.3 43631.1 43975.7 45181.1 59219.4 59931.0 60048.4 61575.4 61634.0 8214.3 8412.4 8505.9 8626.0 8878.2 11851.2 13389.8 13449.5 13796.8 13806.2 11263.4 11291.7 11439.0 11646.5 11674.2 10747.5 10851.3 10909.3 11021.8 11387.2 11384.1 11384.1 11384.3 11513.0 11756.6 7374.6 7501.1 7733.1 8140.3 9045.3 10639.3 11563.5 11627.5 11632.7 12285.8 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#3] mootools.html Cycles:180 Average:5479.66 Median:5030.98 stddev:3103.97 (61.7%) stddev-sans-first:3098.03 18:03:32 INFO - PROCESS | 27331 | Values: 1466.7 1478.9 1569.7 1694.8 1718.0 7194.8 7453.9 7692.9 8127.5 8186.1 7531.8 7758.4 7767.1 7953.5 7991.0 2246.0 2270.9 2273.5 2278.0 2279.0 2217.6 2245.1 2285.0 2286.1 2287.8 2229.3 2240.9 2262.0 2262.9 2267.1 2075.6 2081.3 2094.5 2095.7 2096.1 2222.0 2240.7 2241.2 2243.1 2248.5 8035.8 8040.0 8083.9 8091.8 8111.4 4962.0 4990.9 5071.5 5085.7 5087.9 2981.4 3118.0 3225.5 3311.7 3329.3 1091.5 1107.0 1132.2 1142.5 1158.2 11971.6 12000.8 12030.7 12032.9 12045.9 4223.3 4478.2 4489.4 4601.0 4607.1 9889.8 9904.9 9927.4 9935.3 9940.8 5029.5 5032.4 5090.7 5092.9 5101.6 4041.8 4534.7 4641.8 4646.3 4648.8 3859.1 3867.5 3898.5 4000.6 4015.3 1302.6 1303.9 1313.2 1314.9 1321.0 817.9 926.6 930.5 940.0 961.7 5664.1 5686.4 5689.3 5864.3 5903.1 437.8 443.6 447.8 449.4 449.5 3919.5 3920.9 3928.0 3935.4 3958.2 10112.7 10425.5 10437.8 10462.8 10516.9 10304.2 10343.3 10355.7 10379.1 10400.9 7300.5 7463.0 7518.4 7519.4 7532.1 5462.2 5501.3 5538.2 5607.4 5754.6 9403.4 9404.9 9431.6 9489.7 9662.9 9434.0 9529.6 9585.9 9623.9 9641.2 7105.7 7176.6 7302.9 7327.7 7413.6 8026.0 8036.1 8067.7 8081.3 8086.9 6854.5 6972.4 6985.2 7001.9 7070.8 7165.5 7184.8 7248.9 7347.8 7470.8 6635.2 6741.7 6758.1 6761.9 6766.1 4903.8 5015.0 5073.3 5180.2 5244.3 5020.8 5048.5 5116.5 5139.7 5140.8 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#4] prototype.html Cycles:180 Average:4728.38 Median:5389.56 stddev:1399.95 (26.0%) stddev-sans-first:1364.20 18:03:32 INFO - PROCESS | 27331 | Values: 318.9 321.6 334.5 334.8 338.1 5314.7 5438.0 5467.3 5470.7 5479.9 5294.8 5335.9 5338.8 5371.2 5371.5 4211.6 4236.3 4241.8 4246.2 4255.6 3931.7 4123.2 4167.7 4259.0 4272.4 4108.7 4122.7 4134.5 4141.4 4150.2 4118.2 4130.6 4159.6 4198.3 4222.4 3635.2 3695.8 3702.9 3721.5 3721.7 5256.5 5257.4 5257.8 5268.3 5291.8 4779.8 4788.6 4793.0 4797.2 4809.6 5472.9 5614.4 5636.4 5638.5 5650.8 3975.8 3986.6 4000.2 4005.9 4037.4 5764.3 5823.7 5826.2 5833.7 5839.4 3972.6 4116.4 4117.5 4118.4 4131.3 4115.7 4147.1 4151.7 4154.6 4159.9 4722.0 4738.1 4758.7 4765.9 4776.5 5395.5 5658.5 5667.8 5677.2 5683.7 1388.5 1391.9 1396.4 1399.6 1408.8 920.5 945.8 952.7 959.4 961.2 5253.7 5297.4 5316.4 5316.4 5324.7 5601.3 5623.2 5624.7 5642.9 5652.4 5192.4 5352.9 5369.7 5382.4 5383.7 2943.7 2970.2 2984.8 2992.7 2996.9 5798.7 5824.3 5826.7 5838.6 5895.1 5414.7 5594.8 5628.9 5638.4 5691.7 5809.4 5815.8 5827.7 5828.0 5837.2 5563.2 5594.4 5595.8 5607.9 5859.7 5783.5 5803.5 5809.8 5811.9 5834.3 6086.5 6100.0 6103.6 6121.4 6127.4 3869.0 4056.9 4087.0 4090.7 4092.9 5661.7 5824.7 5839.0 5839.2 5842.5 5669.4 5734.3 5734.7 5738.6 5745.9 5681.6 5704.0 5740.0 5753.2 5776.4 5629.9 5650.4 5665.4 5672.5 5694.5 5695.1 5702.3 5711.9 5717.9 5744.9 5463.4 5540.1 5599.6 5617.8 5624.9 18:03:32 INFO - PROCESS | 27331 | 18:03:32 INFO - PROCESS | 27331 | [#5] yui.html Cycles:180 Average:16879.47 Median:27268.85 stddev:22913.66 (84.0%) stddev-sans-first:22945.09 18:03:32 INFO - PROCESS | 27331 | Values: 539.7 577.6 607.1 686.9 695.4 12258.3 12946.5 13103.4 13113.4 13197.9 12382.4 12435.3 12569.9 12574.8 12578.1 497.8 503.0 773.4 781.4 783.4 757.2 779.9 791.3 791.6 791.6 842.4 843.9 844.7 846.4 847.3 836.5 838.3 841.6 843.3 843.5 604.0 608.6 609.3 611.3 613.7 12484.8 12874.0 12898.5 12915.2 12941.0 12574.0 12612.5 12789.3 12834.2 12973.7 9745.5 9942.1 10011.0 10022.4 10061.2 3239.3 3272.5 3296.6 3305.6 3318.5 60893.0 62932.0 63173.7 63855.7 64325.7 9782.9 9860.3 9913.8 10019.6 10062.5 16535.8 16930.9 17487.7 17638.6 17699.0 7286.5 7306.1 7450.0 7594.3 7861.7 4147.5 4231.1 4256.0 4260.2 4272.2 3062.5 3143.9 3149.7 3154.5 3245.6 560.2 561.8 562.7 563.9 574.0 541.6 541.7 559.3 584.6 593.5 7941.8 8602.6 8794.0 8822.9 9005.9 565.5 567.8 601.2 605.4 624.7 3961.2 4135.1 4200.8 4247.5 4329.5 83473.6 83573.6 85338.6 85704.0 90050.5 49546.0 61187.7 74677.0 76617.3 76717.6 68212.3 69834.0 70526.0 71346.5 72638.0 8044.8 8104.6 8360.7 8374.8 8554.4 48185.3 48616.8 49316.0 49653.5 50863.2 53581.5 53619.2 53998.0 59733.0 64492.4 11022.4 11145.6 11388.6 11511.2 11613.4 12591.7 12642.0 13077.3 13264.7 13750.2 11604.2 11980.3 12052.0 12649.9 12939.6 11499.9 11661.0 12111.2 12152.5 12313.9 11536.8 11971.4 12088.1 12228.9 12628.5 9630.0 9805.4 9998.5 10338.2 10711.6 9376.2 9573.3 10299.2 10412.5 10507.8 18:03:32 INFO - PROCESS | 27331 | -------- Summary: end -------- 18:03:32 INFO - PROCESS | 27331 | 18:03:33 INFO - TEST-INFO | 27331: exit 0 18:03:33 INFO - TEST-OK | dromaeo_css | took 1116461ms 18:03:33 INFO - TEST-START | kraken 18:03:33 INFO - operating with platform_type : linux_ 18:03:33 INFO - Initialising browser for kraken test... 18:03:33 INFO - TEST-INFO | started process 27690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOqDpU/profile http://localhost:37353/getInfo.html) 18:03:37 INFO - PROCESS | 27690 | __metrics Screen width/height:1600/1200 18:03:37 INFO - PROCESS | 27690 | colorDepth:24 18:03:37 INFO - PROCESS | 27690 | Browser inner width/height: 1024/697 18:03:37 INFO - PROCESS | 27690 | __metrics 18:03:38 ERROR - PROCESS | 27690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3174: TypeError: this.tabs is undefined 18:03:39 INFO - TEST-INFO | 27690: exit 0 18:03:39 INFO - Browser initialized. 18:03:39 INFO - Running cycle 1/1 for kraken test... 18:03:39 INFO - TEST-INFO | started process 27815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOqDpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:51 INFO - PROCESS | 27815 | RSS: Main: 185638912 18:03:51 INFO - PROCESS | 27815 | 18:03:54 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37353/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:55 INFO - PROCESS | 27815 | RSS: Main: 198422528 18:03:55 INFO - PROCESS | 27815 | 18:03:57 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37353/tests/kraken/driver.html?testName=audio-dft) 18:03:58 INFO - PROCESS | 27815 | RSS: Main: 196329472 18:03:58 INFO - PROCESS | 27815 | 18:04:01 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37353/tests/kraken/driver.html?testName=audio-fft) 18:04:02 INFO - PROCESS | 27815 | RSS: Main: 192667648 18:04:02 INFO - PROCESS | 27815 | 18:04:04 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37353/tests/kraken/driver.html?testName=audio-oscillator) 18:04:04 INFO - PROCESS | 27815 | RSS: Main: 193474560 18:04:04 INFO - PROCESS | 27815 | 18:04:06 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:07 INFO - PROCESS | 27815 | RSS: Main: 193462272 18:04:07 INFO - PROCESS | 27815 | 18:04:10 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37353/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:11 INFO - PROCESS | 27815 | RSS: Main: 194142208 18:04:11 INFO - PROCESS | 27815 | 18:04:14 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37353/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:15 INFO - PROCESS | 27815 | RSS: Main: 191881216 18:04:15 INFO - PROCESS | 27815 | 18:04:18 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37353/tests/kraken/driver.html?testName=json-parse-financial) 18:04:18 INFO - PROCESS | 27815 | RSS: Main: 192970752 18:04:18 INFO - PROCESS | 27815 | 18:04:20 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:20 INFO - PROCESS | 27815 | RSS: Main: 193122304 18:04:20 INFO - PROCESS | 27815 | 18:04:22 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:23 INFO - PROCESS | 27815 | RSS: Main: 193609728 18:04:23 INFO - PROCESS | 27815 | 18:04:25 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:25 INFO - PROCESS | 27815 | RSS: Main: 193699840 18:04:25 INFO - PROCESS | 27815 | 18:04:28 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:29 INFO - PROCESS | 27815 | RSS: Main: 193826816 18:04:29 INFO - PROCESS | 27815 | 18:04:32 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:32 INFO - PROCESS | 27815 | RSS: Main: 193847296 18:04:32 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | Cycle 1(1): loaded http://localhost:37353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37353/tests/kraken/driver.html?testName=ai-astar) 18:04:34 INFO - PROCESS | 27815 | RSS: Main: 195149824 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | __start_tp_report 18:04:34 INFO - PROCESS | 27815 | _x_x_mozilla_page_load 18:04:34 INFO - PROCESS | 27815 | _x_x_mozilla_page_load_details 18:04:34 INFO - PROCESS | 27815 | |i|pagename|runs| 18:04:34 INFO - PROCESS | 27815 | |0;ai-astar;106;114;115;115;113;114;115;114;113;114 18:04:34 INFO - PROCESS | 27815 | |1;audio-beat-detection;158;126;127;169;125;125;124;126;149;123 18:04:34 INFO - PROCESS | 27815 | |2;audio-dft;161;163;164;177;162;165;162;163;163;163 18:04:34 INFO - PROCESS | 27815 | |3;audio-fft;76;75;75;114;85;75;76;75;117;76 18:04:34 INFO - PROCESS | 27815 | |4;audio-oscillator;82;82;108;83;83;82;101;83;82;110 18:04:34 INFO - PROCESS | 27815 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;117;118;117 18:04:34 INFO - PROCESS | 27815 | |6;imaging-darkroom;148;147;147;147;147;148;148;147;148;147 18:04:34 INFO - PROCESS | 27815 | |7;imaging-desaturate;86;85;86;86;85;85;85;86;86;85 18:04:34 INFO - PROCESS | 27815 | |8;json-parse-financial;54;54;51;56;54;59;54;54;54;54 18:04:34 INFO - PROCESS | 27815 | |9;json-stringify-tinderbox;63;63;62;64;65;63;62;63;62;62 18:04:34 INFO - PROCESS | 27815 | |10;stanford-crypto-aes;82;81;81;81;81;81;79;89;83;80 18:04:34 INFO - PROCESS | 27815 | |11;stanford-crypto-ccm;137;148;142;133;131;140;140;141;195;132 18:04:34 INFO - PROCESS | 27815 | |12;stanford-crypto-pbkdf2;167;165;166;164;165;167;165;163;163;163 18:04:34 INFO - PROCESS | 27815 | |13;stanford-crypto-sha256-iterative;65;65;65;65;68;67;72;66;67;70 18:04:34 INFO - PROCESS | 27815 | __end_tp_report 18:04:34 INFO - PROCESS | 27815 | __start_cc_report 18:04:34 INFO - PROCESS | 27815 | _x_x_mozilla_cycle_collect,827 18:04:34 INFO - PROCESS | 27815 | __end_cc_report 18:04:34 INFO - PROCESS | 27815 | __startTimestamp1478916274816__endTimestamp 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | ------- Summary: start ------- 18:04:34 INFO - PROCESS | 27815 | Number of tests: 14 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.67 (2.3%) stddev-sans-first:0.78 18:04:34 INFO - PROCESS | 27815 | Values: 106.0 114.0 115.0 115.0 113.0 114.0 115.0 114.0 113.0 114.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:126.50 stddev:16.90 (13.4%) stddev-sans-first:15.79 18:04:34 INFO - PROCESS | 27815 | Values: 158.0 126.0 127.0 169.0 125.0 125.0 124.0 126.0 149.0 123.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.60 (2.8%) stddev-sans-first:4.72 18:04:34 INFO - PROCESS | 27815 | Values: 161.0 163.0 164.0 177.0 162.0 165.0 162.0 163.0 163.0 163.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#3] audio-fft Cycles:10 Average:84.40 Median:75.50 stddev:16.68 (22.1%) stddev-sans-first:17.41 18:04:34 INFO - PROCESS | 27815 | Values: 76.0 75.0 75.0 114.0 85.0 75.0 76.0 75.0 117.0 76.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:11.77 (14.4%) stddev-sans-first:12.16 18:04:34 INFO - PROCESS | 27815 | Values: 82.0 82.0 108.0 83.0 83.0 82.0 101.0 83.0 82.0 110.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:04:34 INFO - PROCESS | 27815 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:04:34 INFO - PROCESS | 27815 | Values: 148.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:04:34 INFO - PROCESS | 27815 | Values: 86.0 85.0 86.0 86.0 85.0 85.0 85.0 86.0 86.0 85.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.01 (3.7%) stddev-sans-first:2.13 18:04:34 INFO - PROCESS | 27815 | Values: 54.0 54.0 51.0 56.0 54.0 59.0 54.0 54.0 54.0 54.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 18:04:34 INFO - PROCESS | 27815 | Values: 63.0 63.0 62.0 64.0 65.0 63.0 62.0 63.0 62.0 62.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:2.74 (3.4%) stddev-sans-first:2.91 18:04:34 INFO - PROCESS | 27815 | Values: 82.0 81.0 81.0 81.0 81.0 81.0 79.0 89.0 83.0 80.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.50 stddev:18.69 (13.3%) stddev-sans-first:19.66 18:04:34 INFO - PROCESS | 27815 | Values: 137.0 148.0 142.0 133.0 131.0 140.0 140.0 141.0 195.0 132.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:1.55 (0.9%) stddev-sans-first:1.42 18:04:34 INFO - PROCESS | 27815 | Values: 167.0 165.0 166.0 164.0 165.0 167.0 165.0 163.0 163.0 163.0 18:04:34 INFO - PROCESS | 27815 | 18:04:34 INFO - PROCESS | 27815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.40 (3.6%) stddev-sans-first:2.44 18:04:34 INFO - PROCESS | 27815 | Values: 65.0 65.0 65.0 65.0 68.0 67.0 72.0 66.0 67.0 70.0 18:04:34 INFO - PROCESS | 27815 | -------- Summary: end -------- 18:04:34 INFO - PROCESS | 27815 | 18:04:35 INFO - TEST-INFO | 27815: exit 0 18:04:36 INFO - TEST-OK | kraken | took 62385ms 18:04:36 INFO - SUITE-END | took 1178s 18:04:36 INFO - Completed test suite (00:19:39) 18:04:36 INFO - javascript benchmark 18:04:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6922.726765848718, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.672126066133, 2989.073387249954, 3025.152957171991, 3025.6671766105724, 3028.6971302869715, 5239.842804715855, 5265.315508983832, 5334.333208348961, 5339.786408543659, 5392.514673679368, 5316.7873285068645, 5344.839654810362, 5369.167778994262, 5371.4897084776985, 5374.462553744624, 4829.855104346866, 4909.263610458442, 4935.259711043336, 4953.727544985024, 4983.327250821148, 4922.433920099181, 4956.058348913695, 4995.0, 4996.0, 5043.268726034723, 4880.926786098212, 4970.030843985424, 5015.247712843066, 5021.698698078127, 5026.29631851541, 4733.077049975256, 4954.529319714621, 4958.677685950438, 5015.949840501585, 5036.7733451994745, 4760.214564596838, 4811.254255590389, 4816.0, 4819.879503012417, 4821.927671084936, 5218.712970786605, 5229.581633469314, 5275.103232450492, 5278.498542638443, 5285.339332583427, 5632.436756324376, 5663.830085097413, 5705.914411283834, 5711.371749107595, 5752.050911599581, 5808.82573522795, 5808.82573522795, 5812.186293918855, 5818.0981947798155, 5834.912476312858, 5321.760520776575, 5364.061289274361, 5420.159875219387, 5428.131498960187, 5435.320584926884, 5820.941790582125, 5864.9413505864395, 5873.442023007808, 5874.206982057453, 5911.054231322968, 5621.606487545832, 5628.352739434936, 5652.830415087554, 5655.915161272585, 5674.602777805597, 5582.86042848932, 5604.85987850307, 5611.466910643482, 5661.688607126565, 5706.201131841545, 5519.061759500894, 5616.775328986876, 5660.8867822643315, 5661.745221465044, 5688.175214593861, 5502.504774570308, 5534.142207957773, 5660.066089095336, 5756.136579513023, 5799.536037117105, 4427.649566882067, 4438.778061096932, 4470.240059189946, 4475.686701930898, 4489.32660100981, 3921.8039098044983, 3932.744371615836, 3949.585293544194, 3962.6037396260144, 4025.094353770437, 5401.432849550819, 5442.510174084351, 5447.945520544823, 5463.972680136653, 5551.2228288039705, 5666.433356664301, 5695.515881150149, 5732.598718089694, 5743.85640358986, 5824.359320474744, 5518.227448157261, 5534.1145416733125, 5536.695481748462, 5543.2793736814765, 5555.583331250173, 4920.335754673145, 4924.3105965164905, 4929.408470983505, 4940.086084074458, 4984.177610694195, 5840.3575606683235, 5903.970480147572, 5904.704764761745, 5937.465628093492, 5978.850528736816, 5748.597598168088, 5761.0, 5772.249607550992, 5808.854778630568, 5808.883822323614, 5927.7036148191555, 6027.60820546663, 6030.517558595389, 6035.155078288955, 6065.696715164136, 5586.720663966867, 5647.491725744702, 5681.801136960186, 5686.687232202268, 5692.715364231689, 5747.051736463437, 5749.8562535936935, 5761.991651461061, 5762.337331206965, 5765.250517432874, 5608.775648974159, 5610.382857885547, 5613.0, 5617.157426386075, 5617.915731263953, 5579.581531385244, 5606.85982850432, 5607.0, 5613.214150018919, 5740.741666625096, 5599.384067752625, 5628.549716022627, 5639.379668236573, 5657.0, 5676.9716151420635, 5685.0, 5689.089745640677, 5698.088305871041, 5717.313922329347, 5724.084146536534, 5414.0, 5530.308711411074, 5545.528630066489, 5552.944470555242, 5633.971830140823], "value": 5298.713951888342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.9517643412092, 537.2937175905678, 547.3568556945588, 575.6891278709496, 589.0633892111543, 40456.19087618246, 41741.0, 41822.790886045565, 44771.55228447715, 44956.0, 43076.35385469221, 43243.3513497297, 43427.56572434275, 43551.56448435515, 43551.56448435523, 8485.406021578476, 8668.913310866874, 8676.392652514327, 8676.436031657922, 8730.563471826383, 8559.400841941067, 8638.04981452043, 8656.740297791077, 8658.047614762403, 8668.783280417976, 8216.548089855056, 8223.794405139859, 8248.958755206215, 8278.296344810698, 8305.916940830575, 8684.956575217084, 8718.912810871905, 8733.650653973866, 8760.386772925898, 8765.912340876574, 8353.707620233323, 8458.87311690325, 8476.152384761535, 8479.745607631781, 8482.406231563793, 40719.38920916188, 41275.174496510204, 41439.585604143875, 41468.37797433041, 41473.0, 3103.67411421802, 3136.200268931431, 3205.9038228853174, 3346.9497957530657, 3439.466882633196, 30403.847980760176, 30555.847220763753, 30972.690273097207, 31014.534781978287, 32537.6746232537, 3615.403458429356, 3620.9366063507523, 3645.9270814583824, 3686.170611612366, 3751.4372844073337, 326328.0, 326990.0, 328320.0, 328648.0, 329273.0, 57369.0, 57486.7125664369, 57527.0, 57622.0, 57716.42283577195, 59465.70267148637, 59715.70142149262, 59902.70048649729, 60057.399426005184, 60163.39836601578, 14456.494022709154, 14608.415663373558, 14634.780478292834, 14649.707005859824, 14706.63233419173, 11586.073114150848, 11669.474873630706, 11681.415929203506, 11709.414529273503, 11732.41337933117, 16971.830281697024, 17498.300067997137, 17630.0, 17652.293908243526, 17686.646267074586, 5947.520700390233, 6032.879342413127, 6045.848853778691, 6201.658908759971, 6236.066819286036, 890.3589415620743, 984.1880448629909, 1033.2973577967055, 1124.0164855751218, 1141.9429028548539, 31176.0, 31344.843275783474, 31549.52675709866, 32112.35775284528, 32177.195570110933, 1070.9357438553711, 1088.9237753357347, 1096.753230523126, 1114.0419239454063, 1138.9772204555863, 16663.750043749355, 17499.475015749547, 17531.474055778348, 18247.270109195484, 18427.72358414625, 491265.0, 497492.0, 500916.0, 501368.0, 501594.0, 56081.0, 56185.438145618835, 56366.43633563612, 56454.15318770222, 56494.43505564974, 1009.0918173643779, 1063.9574417023387, 1069.4385447640052, 1070.384528895888, 1229.9053842080555, 24769.0, 26225.868870655526, 26833.865830670722, 26859.194224173305, 27031.72968270292, 50194.0, 51422.0, 53856.0, 54205.72897135647, 59061.0, 336385.0, 337089.0, 339313.0, 339629.0, 342329.0, 40375.1924961505, 41022.58977410307, 41389.58610413857, 41391.7930410346, 42144.578554214066, 46284.53715462802, 46388.768056159504, 47482.28776568285, 47800.282995755784, 48083.27875081806, 30893.227669308446, 31434.685653143177, 31463.528047078853, 31471.84264078665, 32662.0, 40363.19273614453, 40450.797746011085, 40693.38959915663, 40820.59179408168, 40853.79573102116, 38378.0, 39887.0, 40022.59920902755, 40568.79715601403, 40672.79663601663, 33350.49716796701, 35685.46471802977, 35696.64303356933, 36727.0, 36960.445593315584, 27324.72675273222, 27857.582136267567, 28139.0, 28237.43525129445, 28244.576331355456], "value": 19127.400244978075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.82383279858476, 385.283372926357, 386.11940151492746, 395.1149425287357, 417.96656267498605, 18902.52743681407, 19371.612567748638, 19382.0, 19448.0, 19705.31031413901, 17682.0, 17698.823011769877, 18116.4565063048, 18294.81705182948, 18505.537361565934, 5427.158790387486, 5437.238786569884, 5678.233438485813, 5680.687562184078, 5742.827715168552, 5793.768249270045, 5801.274840644919, 5819.039858423355, 5829.0964900440285, 5838.824835254949, 5660.773569057233, 5742.310922689262, 5786.334571524287, 5800.266231920897, 5826.621269617462, 5797.507211886974, 5839.153322768218, 5844.620099693528, 5855.092460668582, 5855.912161317584, 5466.289382380305, 5544.251526044013, 5615.2700148980375, 5628.0, 5629.211910332557, 13501.729965400637, 13548.796768048487, 13591.184528928197, 13927.860721392859, 14062.0, 2287.1080278691325, 2288.8054515366216, 2302.3668491164894, 2319.5824751544715, 2804.102687140116, 10075.868295432472, 10236.232282578836, 10676.199285053573, 10767.407792571405, 13565.050446468751, 1858.8419984301352, 1862.8230318119893, 1867.8599105067174, 1901.9904900475547, 1938.0116140768168, 77815.6109219456, 78498.60750696267, 78575.0, 79329.60335198345, 81755.59122204351, 10270.0, 10352.741181470374, 10436.582536698446, 10461.0, 10495.317804342692, 13817.065610814494, 13832.723345533033, 13888.305584720723, 14027.438902443992, 14204.0, 7545.622718864035, 7563.546187228784, 7663.157052724196, 7707.730229441942, 7724.961375193088, 7152.964235178791, 7302.05073340473, 7310.890336644955, 7441.665125069277, 7505.924940750632, 4209.305464598368, 4226.344916537942, 4283.336082907154, 4304.439451383227, 4408.360787685831, 1973.7236786849853, 1974.7926467720683, 2011.9195232190548, 2017.6569983102909, 2034.3591768592846, 849.6856163219649, 954.370115723619, 979.686500319905, 996.9551370188359, 1022.7801022779989, 18089.366872159673, 18974.62050758977, 19448.319308824124, 19843.107060182327, 20064.39806805769, 978.2272005116021, 1008.9949550252202, 1009.7172791618211, 1040.47976011994, 1057.6509751781894, 10304.845427318596, 10869.67390978272, 10993.120550355952, 11002.284851484628, 11035.282706624044, 406129.0, 407576.0, 410380.0, 410673.0, 411597.0, 86287.0, 88206.55896720475, 93910.11886346259, 94865.52567237258, 101191.0, 950.0736781637847, 975.1370037516849, 979.2019504104275, 983.1888691829126, 985.4284514981293, 16548.255328510004, 17843.286268549113, 18103.456896293133, 18234.635307294044, 18360.63278734391, 43024.56975430331, 43351.34972975345, 43631.12737745291, 43975.68072957816, 45181.096378072914, 59219.407805921386, 59931.0, 60048.39951600603, 61575.384246156966, 61634.0, 8214.26071653554, 8412.369072319723, 8505.91494085076, 8626.0, 8878.245349145394, 11851.170418070653, 13389.799153012518, 13449.529266475627, 13796.793048104086, 13806.17162970225, 11263.380514071478, 11291.717707057389, 11438.992705106293, 11646.475908583965, 11674.241174323643, 10747.516361763583, 10851.348919064882, 10909.34543927367, 11021.83467247976, 11387.202895797214, 11384.121619932619, 11384.14618903569, 11384.260023098472, 11513.0, 11756.58851940178, 7374.631268436664, 7501.137369202612, 7733.149353570991, 8140.308073813792, 9045.276377889884, 10639.308444951053, 11563.537458501565, 11627.53489860396, 11632.651020469399, 12285.815712764137], "value": 8933.31694934141, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.7213229486397, 1478.896477246593, 1569.7096037233114, 1694.8135705072432, 1717.9656406871864, 7194.784156475314, 7453.881917712332, 7692.884606730897, 8127.512349259048, 8186.099529051807, 7531.849363012737, 7758.379329653629, 7767.106782719989, 7953.483023603476, 7990.960045199766, 2245.9887700561476, 2270.852394594346, 2273.533925545259, 2277.977220227793, 2278.977210227901, 2217.589745897006, 2245.146844199202, 2285.0402830811017, 2286.0627142871426, 2287.7597852225526, 2229.3312006398096, 2240.932772016842, 2262.0386335807298, 2262.8868556572106, 2267.115824828318, 2075.616011037963, 2081.2923605973965, 2094.4554415851835, 2095.6646936490165, 2096.0986775686447, 2222.0, 2240.6975058367075, 2241.1707668162885, 2243.14760391052, 2248.482848944752, 8035.799105022363, 8039.95980020102, 8083.878741818878, 8091.797705057421, 8111.351091912633, 4961.950380496185, 4990.90018199634, 5071.492850714936, 5085.74571271435, 5087.872803179913, 2981.403719256136, 3117.9688203117908, 3225.5000474926424, 3311.6688331166933, 3329.267561136546, 1091.5142761471147, 1106.9723256918642, 1132.2300835431904, 1142.53156205956, 1158.1661203933154, 11971.64085077449, 12000.759984800343, 12030.699232519257, 12032.879671203264, 12045.93977030118, 4223.345381465878, 4478.171538265431, 4489.361383095147, 4600.953990460052, 4607.124646317189, 9889.752756181153, 9904.851427228597, 9927.40435573868, 9935.254855885838, 9940.801183976424, 5029.547340739277, 5032.421271553745, 5090.669106508065, 5092.949070509321, 5101.591872650179, 4041.78746376086, 4534.659900507475, 4641.814327426932, 4646.279826626878, 4648.83729069481, 3859.0931131184147, 3867.497225360685, 3898.493195884517, 4000.6199411055904, 4015.3374693175297, 1302.5766625846638, 1303.8565757766637, 1313.2317594207495, 1314.9013823963242, 1320.966975825612, 817.9222973817477, 926.6386109417333, 930.5254320296698, 939.96710115147, 961.7211008807508, 5664.065429204135, 5686.431356864363, 5689.317281926195, 5864.296284445893, 5903.144044113579, 437.7942367087464, 443.58967954641827, 447.8007286757427, 449.40678304637566, 449.4898290440374, 3919.529656441245, 3920.862769803043, 3928.0, 3935.4490371348033, 3958.2083583282883, 10112.696619101438, 10425.478726063666, 10437.843432348369, 10462.843057354146, 10516.894831051592, 10304.227182961158, 10343.27597068198, 10355.741106472398, 10379.065884070318, 10400.895991040145, 7300.452466065172, 7462.96268518654, 7518.360939320219, 7519.360854327334, 7532.096148462219, 5462.235287059894, 5501.339839219319, 5538.196961440649, 5607.383187849415, 5754.56840736938, 9403.43579385239, 9404.905950940676, 9431.57557909882, 9489.66786162481, 9662.9033709662, 9434.0, 9529.618815247313, 9585.856212156683, 9623.855642165234, 9641.228701703987, 7105.680244389118, 7176.641167941686, 7302.890456643261, 7327.74352897646, 7413.629318534159, 8026.0, 8036.075851277178, 8067.717629882926, 8081.313088387553, 8086.87869681967, 6854.5201835873, 6972.4073453757, 6985.231624521197, 7001.929980700128, 7070.787876363717, 7165.534240274365, 7184.820379490346, 7248.855022899618, 7347.7795666130105, 7470.775876723707, 6635.2037755469655, 6741.696623651849, 6758.121444212221, 6761.864762704817, 6766.086578311865, 4903.828366007173, 5014.974925125351, 5073.34046573943, 5180.248863914787, 5244.292020577326, 5020.774065167003, 5048.5203905628905, 5116.488351164854, 5139.743012849417, 5140.820071297487], "value": 4345.037056690915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8644825948971, 321.6237002706833, 334.52974178485556, 334.84095054848945, 338.0955942852868, 5314.7314401643, 5438.0, 5467.316585426822, 5470.699111548864, 5479.945200547993, 5294.835136270024, 5335.919961200585, 5338.759755810988, 5371.194320851864, 5371.454839805729, 4211.599898009684, 4236.279832428495, 4241.830326786932, 4246.214450326699, 4255.553166917475, 3931.6658084062888, 4123.175364927027, 4167.666586673074, 4258.956555643872, 4272.444582204309, 4108.691848111389, 4122.690798190133, 4134.545200027995, 4141.4202011718235, 4150.211459822624, 4118.176364727052, 4130.6282434581035, 4159.646430053464, 4198.307279298942, 4222.387753775716, 3635.1820840310984, 3695.7597756145765, 3702.9259414811822, 3721.5162028936065, 3721.702263818888, 5256.500632439912, 5257.447967963385, 5257.76340064698, 5268.262443257909, 5291.814786482455, 4779.761011949424, 4788.640851936118, 4792.952070479286, 4797.208460603996, 4809.591184749301, 5472.890542189174, 5614.3543492498475, 5636.436356364372, 5638.4925356718095, 5650.773969041234, 3975.7813320267373, 3986.5814089520472, 4000.159966407058, 4005.859794907164, 4037.4347591337237, 5764.308283006024, 5823.737931793079, 5826.242588463472, 5833.7083145842535, 5839.386864379221, 3972.6424621784176, 4116.444280022159, 4117.526484454266, 4118.361653943643, 4131.318332475168, 4115.71190016696, 4147.108371700038, 4151.6886233532005, 4154.646855017358, 4159.939215500028, 4721.952780472151, 4738.147133516, 4758.666893317434, 4765.880852978703, 4776.498467660915, 5395.460453954652, 5658.519025882763, 5667.773289068474, 5677.233573467612, 5683.658980461186, 1388.5001399496173, 1391.9095258808347, 1396.441423430636, 1399.5864177180918, 1408.7532533707742, 920.5259291464901, 945.7824700318965, 952.6522819171091, 959.3620242538773, 961.245422343457, 5253.658512196695, 5297.417284098746, 5316.415194328621, 5316.415194328621, 5324.722066704041, 5601.263608281446, 5623.200575815781, 5624.690642014729, 5642.887142257132, 5652.378238393773, 5192.350956130484, 5352.946470535323, 5369.704666243316, 5382.354117505846, 5383.66212947967, 2943.749781268616, 2970.1980465274255, 2984.8358340291493, 2992.7156920092557, 2996.925076873096, 5798.681072540966, 5824.271966004249, 5826.650400975955, 5838.562107841929, 5895.081934442393, 5414.729263536886, 5594.804181853616, 5628.943710562842, 5638.35158956717, 5691.686957217393, 5809.3609702932645, 5815.79644712433, 5827.65034097964, 5828.0, 5837.241158649348, 5563.193336966198, 5594.41258667834, 5595.817631123784, 5607.943920560742, 5859.677717725566, 5783.450572195635, 5803.47768700819, 5809.82570522885, 5811.912821307768, 5834.299884013776, 6086.478380404898, 6100.0, 6103.572749907464, 6121.387861213843, 6127.356627554221, 3868.9806550967064, 4056.9391459127546, 4086.9578257544135, 4090.734102283342, 4092.856750013735, 5661.716914154358, 5824.737886795019, 5838.970805145947, 5839.1606643908735, 5842.5325973921135, 5669.433056694463, 5734.283214598176, 5734.741936612779, 5738.598298119258, 5745.9425405745405, 5681.630694004876, 5703.971480142573, 5739.971300143473, 5753.223314852608, 5776.42235776419, 5629.859253518531, 5650.406707295675, 5665.433456654467, 5672.5461963042035, 5694.4590263924865, 5695.1457281406465, 5702.258706368146, 5711.914321285101, 5717.914231286451, 5744.913826292693, 5463.399026107046, 5540.119138048273, 5599.60802743804, 5617.775288988395, 5624.887502250014], "value": 4277.934264342728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.6950722841594, 577.5812535911463, 607.1014897951032, 686.8729285082262, 695.3706895259788, 12258.325792081432, 12946.546870859522, 13103.379324135176, 13113.409896554655, 13197.934010329935, 12382.380880955961, 12435.316057616827, 12569.874301256985, 12574.81137782934, 12578.056645751582, 497.8040976928112, 502.96479246452765, 773.4237992695436, 781.4451739265129, 783.3967844759532, 757.2351924556183, 779.9337056350217, 791.2641243643409, 791.5567282321919, 791.6160662078887, 842.3513894301384, 843.8649816029437, 844.7423535821572, 846.4159729786459, 847.3263755314509, 836.5315423362936, 838.3293365307729, 841.5623875584693, 843.3337663246028, 843.4770442325766, 604.0335463258795, 608.6287364707525, 609.2719200555338, 611.2695329081749, 613.6839527643267, 12484.81272780909, 12874.034447416387, 12898.484060637564, 12915.225086494747, 12941.0, 12574.0, 12612.495500180074, 12789.296588687619, 12834.229946203164, 12973.740525189443, 9745.512724363753, 9942.105210531086, 10011.0, 10022.398656080659, 10061.238421254548, 3239.303549736794, 3272.525483804835, 3296.620888597818, 3305.636379998198, 3318.5188147718686, 60893.0, 62932.0, 63173.684131579044, 63855.68072159656, 64325.67837160831, 9782.9021709782, 9860.260480463994, 9913.75215619601, 10019.599216031276, 10062.547185376676, 16535.751963720555, 16930.91534542344, 17487.65024699499, 17638.559036024202, 17699.0, 7286.453515986323, 7306.123265208209, 7450.0, 7594.278543538355, 7861.685532578747, 4147.52303485097, 4231.111466591989, 4256.042390462183, 4260.169266992907, 4272.188284225987, 3062.540618907182, 3143.8899638512544, 3149.653538110806, 3154.542591324245, 3245.6429792722784, 560.1849309255024, 561.7668667503023, 562.7439713079773, 563.943605639441, 574.0, 541.6371031408966, 541.6831153775007, 559.2924949938331, 584.6433675457968, 593.4658807073669, 7941.841163176704, 8602.569676616547, 8794.008763033404, 8822.86765698515, 9005.909940900638, 565.4854082784728, 567.8410045187354, 601.1703848688782, 605.391581460638, 624.7313655128338, 3961.207758448322, 4135.0902801383645, 4200.788520104316, 4247.469066366704, 4329.458817647794, 83473.58263208767, 83573.58213208895, 85338.57330713431, 85704.0, 90050.54974725084, 49546.0, 61187.694061530296, 74677.0, 76617.33826617294, 76717.61641191758, 68212.31787682159, 69834.0, 70526.0, 71346.50861659554, 72638.0, 8044.758657240292, 8104.554249516334, 8360.749177524684, 8374.827524146745, 8554.358423118416, 48185.27722084102, 48616.75691621519, 49316.0, 49653.503464966336, 50863.237051445, 53581.46418535765, 53619.19571206357, 53998.0, 59733.0, 64492.355076448635, 11022.448877556251, 11145.609903653332, 11388.601398951329, 11511.19421640477, 11613.419329033684, 12591.748165036464, 12642.0, 13077.346132693518, 13264.734705305647, 13750.174989500661, 11604.245724027911, 11980.28118312904, 12052.0, 12649.87350126487, 12939.611811645666, 11499.885001149882, 11661.0, 12111.212771169845, 12152.513899443924, 12313.93843030815, 11536.769264614828, 11971.426143379214, 12088.093392995384, 12228.938855305667, 12628.494860205856, 9630.0, 9805.362651427635, 9998.500074996367, 10338.224633152393, 10711.596667148726, 9376.156145946898, 9573.32986690925, 10299.227557933034, 10412.47937603132, 10507.842382364117], "value": 6539.606925254018, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 127.0, 169.0, 125.0, 125.0, 124.0, 126.0, 149.0, 123.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 177.0, 162.0, 165.0, 162.0, 163.0, 163.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 114.0, 85.0, 75.0, 76.0, 75.0, 117.0, 76.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 83.0, 83.0, 82.0, 101.0, 83.0, 82.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 51.0, 56.0, 54.0, 59.0, 54.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 65.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 81.0, 81.0, 79.0, 89.0, 83.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 148.0, 142.0, 133.0, 131.0, 140.0, 140.0, 141.0, 195.0, 132.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 164.0, 165.0, 167.0, 165.0, 163.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 68.0, 67.0, 72.0, 66.0, 67.0, 70.0], "value": 67.0, "unit": "score"}]}]} 18:04:36 INFO - Return code: 0 18:04:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:36 ERROR - # TBPL SUCCESS # 18:04:36 INFO - Running post-action listener: _resource_record_post_action 18:04:36 INFO - [mozharness: 2016-11-12 02:04:36.625860Z] Finished run-tests step (success) 18:04:36 INFO - Running post-run listener: _resource_record_post_run 18:04:36 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392646656; Read time: 8; Write time: 297472 18:04:36 INFO - TinderboxPrint: CPU usage
13.4% 18:04:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:04:36 INFO - TinderboxPrint: I/O write bytes / time
392,646,656 / 297,472 18:04:36 INFO - TinderboxPrint: CPU idle
8,254.9 (86.5%) 18:04:36 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 18:04:36 INFO - TinderboxPrint: Swap in / out
0 / 0 18:04:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102723584; Read time: 0; Write time: 69028 18:04:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288661504; Read time: 0; Write time: 228372 18:04:37 INFO - Running post-run listener: _upload_blobber_files 18:04:37 INFO - Blob upload gear active. 18:04:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:37 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 18:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:40 INFO - (blobuploader) - INFO - Done attempting. 18:04:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:41 INFO - (blobuploader) - INFO - Done attempting. 18:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:42 INFO - (blobuploader) - INFO - Done attempting. 18:04:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:42 INFO - Return code: 0 18:04:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70758bf69ad32ea1da024846e47edb0ec5ca9624c13b0a9cf0f806da1fdcd49fb01dc0b05dfec6241bdc3a9de01804a0b0c8aafb20a2fcc8624bbac37dfe43cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd0a69405f1893eeb8cff530c6e0ba13dc9bb73ea07d5e5201f6fc08e10eb1b1f18a0eeadb5871090414d6be8a1413789d024ec5be6a68fd3e6c81ce609a8b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49332d68377c9bc801196a3ab1b65ad241e82616610df07f06c4431f8584544670ef5ca3a91170a40a3fa1e7806169c68ff9be28261f73685d778f78b77e1315"} 18:04:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:42 INFO - Contents: 18:04:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70758bf69ad32ea1da024846e47edb0ec5ca9624c13b0a9cf0f806da1fdcd49fb01dc0b05dfec6241bdc3a9de01804a0b0c8aafb20a2fcc8624bbac37dfe43cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd0a69405f1893eeb8cff530c6e0ba13dc9bb73ea07d5e5201f6fc08e10eb1b1f18a0eeadb5871090414d6be8a1413789d024ec5be6a68fd3e6c81ce609a8b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49332d68377c9bc801196a3ab1b65ad241e82616610df07f06c4431f8584544670ef5ca3a91170a40a3fa1e7806169c68ff9be28261f73685d778f78b77e1315"} 18:04:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:42 INFO - Copying logs to upload dir... 18:04:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.843515 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-11 18:04:42.511014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 18:04:42.515201) ========= 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=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70758bf69ad32ea1da024846e47edb0ec5ca9624c13b0a9cf0f806da1fdcd49fb01dc0b05dfec6241bdc3a9de01804a0b0c8aafb20a2fcc8624bbac37dfe43cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd0a69405f1893eeb8cff530c6e0ba13dc9bb73ea07d5e5201f6fc08e10eb1b1f18a0eeadb5871090414d6be8a1413789d024ec5be6a68fd3e6c81ce609a8b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49332d68377c9bc801196a3ab1b65ad241e82616610df07f06c4431f8584544670ef5ca3a91170a40a3fa1e7806169c68ff9be28261f73685d778f78b77e1315"} build_url:https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/TFYxImvPSxmPwg0HcdsmdA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70758bf69ad32ea1da024846e47edb0ec5ca9624c13b0a9cf0f806da1fdcd49fb01dc0b05dfec6241bdc3a9de01804a0b0c8aafb20a2fcc8624bbac37dfe43cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd0a69405f1893eeb8cff530c6e0ba13dc9bb73ea07d5e5201f6fc08e10eb1b1f18a0eeadb5871090414d6be8a1413789d024ec5be6a68fd3e6c81ce609a8b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49332d68377c9bc801196a3ab1b65ad241e82616610df07f06c4431f8584544670ef5ca3a91170a40a3fa1e7806169c68ff9be28261f73685d778f78b77e1315"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 18:04:42.541468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 18:04:42.541835) ========= 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=17051fcd5208b27b50bedfeb000001dd-1478915019.904898-1225195444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 18:04:42.627231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 18:04:42.627612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 18:04:42.627989) ========= ========= Total master_lag: 0.19 =========