builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1476298990.33 results: success (0) buildid: 20161012103646 builduid: 7987455842ae4052a3bf33b0eb4b7360 revision: e3a490dbfea76cf18008824f3a7a8675ad4c3fee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.330907) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.331443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.331786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.346618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.347005) ========= 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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 12:03:11-- 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% 225M=0s 2016-10-12 12:03:11 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.458891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.459708) ========= 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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016023 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:10.510790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 12:03:10.511204) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e3a490dbfea76cf18008824f3a7a8675ad4c3fee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e3a490dbfea76cf18008824f3a7a8675ad4c3fee --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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 12:03:11,402 truncating revision to first 12 chars 2016-10-12 12:03:11,402 Setting DEBUG logging. 2016-10-12 12:03:11,402 attempt 1/10 2016-10-12 12:03:11,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e3a490dbfea7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 12:03:12,533 unpacking tar archive at: autoland-e3a490dbfea7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 12:03:11.996588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:11.997361) ========= script_repo_revision: e3a490dbfea76cf18008824f3a7a8675ad4c3fee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:11.998392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:11.998996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 12:03:12.010690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 12:03:12.011007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:03:12 INFO - MultiFileLogger online at 20161012 12:03:12 in /builds/slave/test 12:03:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:03:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:03:12 INFO - {'append_to_log': False, 12:03:12 INFO - 'base_work_dir': '/builds/slave/test', 12:03:12 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:03:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:03:12 INFO - 'branch': 'Autoland-Non-PGO', 12:03:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:03:12 INFO - 'config_files': ('talos/linux_config.py',), 12:03:13 INFO - 'default_actions': ('clobber', 12:03:13 INFO - 'read-buildbot-config', 12:03:13 INFO - 'download-and-extract', 12:03:13 INFO - 'populate-webroot', 12:03:13 INFO - 'create-virtualenv', 12:03:13 INFO - 'install', 12:03:13 INFO - 'run-tests'), 12:03:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:03:13 INFO - 'download_minidump_stackwalk': True, 12:03:13 INFO - 'download_symbols': 'ondemand', 12:03:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:03:13 INFO - 'tooltool.py': '/tools/tooltool.py', 12:03:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:03:13 INFO - '/tools/misc-python/virtualenv.py')}, 12:03:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:03:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:03:13 INFO - 'installer_path': 'installer.exe', 12:03:13 INFO - 'log_level': 'info', 12:03:13 INFO - 'log_name': 'talos', 12:03:13 INFO - 'log_to_console': True, 12:03:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:03:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:03:13 INFO - 'opt_config_files': (), 12:03:13 INFO - 'pip_index': False, 12:03:13 INFO - 'sps_profile': False, 12:03:13 INFO - 'sps_profile_interval': 0, 12:03:13 INFO - 'suite': 'dromaeojs', 12:03:13 INFO - 'system_bits': '32', 12:03:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:03:13 INFO - 'title': 'talos-linux64-ix-025', 12:03:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:03:13 INFO - 'use_talos_json': True, 12:03:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:03:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:03:13 INFO - 'work_dir': 'build'} 12:03:13 INFO - [mozharness: 2016-10-12 19:03:13.003324Z] Running clobber step. 12:03:13 INFO - Running pre-action listener: _resource_record_pre_action 12:03:13 INFO - Running main action method: clobber 12:03:13 INFO - rmtree: /builds/slave/test/build 12:03:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:03:14 INFO - Running post-action listener: _resource_record_post_action 12:03:14 INFO - [mozharness: 2016-10-12 19:03:14.009624Z] Finished clobber step (success) 12:03:14 INFO - [mozharness: 2016-10-12 19:03:14.009724Z] Running read-buildbot-config step. 12:03:14 INFO - Running pre-action listener: _resource_record_pre_action 12:03:14 INFO - Running main action method: read_buildbot_config 12:03:14 INFO - Using buildbot properties: 12:03:14 INFO - { 12:03:14 INFO - "project": "", 12:03:14 INFO - "product": "firefox", 12:03:14 INFO - "script_repo_revision": "production", 12:03:14 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:03:14 INFO - "repository": "", 12:03:14 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:03:14 INFO - "buildid": "20161012103646", 12:03:14 INFO - "pgo_build": "False", 12:03:14 INFO - "basedir": "/builds/slave/test", 12:03:14 INFO - "buildnumber": 791, 12:03:14 INFO - "slavename": "talos-linux64-ix-025", 12:03:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:03:14 INFO - "platform": "ubuntu64_hw", 12:03:14 INFO - "scheduler": "tests-autoland-linux64-talos", 12:03:14 INFO - "branch": "autoland", 12:03:14 INFO - "repo_path": "integration/autoland", 12:03:14 INFO - "revision": "e3a490dbfea76cf18008824f3a7a8675ad4c3fee", 12:03:14 INFO - "stage_platform": "linux64", 12:03:14 INFO - "builduid": "7987455842ae4052a3bf33b0eb4b7360", 12:03:14 INFO - "slavebuilddir": "test" 12:03:14 INFO - } 12:03:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:03:14 INFO - Running post-action listener: _resource_record_post_action 12:03:14 INFO - [mozharness: 2016-10-12 19:03:14.012196Z] Finished read-buildbot-config step (success) 12:03:14 INFO - [mozharness: 2016-10-12 19:03:14.012286Z] Running download-and-extract step. 12:03:14 INFO - Running pre-action listener: _resource_record_pre_action 12:03:14 INFO - Running main action method: download_and_extract 12:03:14 INFO - mkdir: /builds/slave/test/build/tests 12:03:14 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')]} 12:03:14 INFO - trying https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:03:14 INFO - Downloading https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/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 12:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/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 12:03:14 INFO - Downloaded 1361 bytes. 12:03:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:03:14 INFO - Using the following test package requirements: 12:03:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:03:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:03:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:03:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'jsshell-linux-x86_64.zip'], 12:03:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:03:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:03:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:03:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:03:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:03:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:03:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:03:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:03:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:03:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:03:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:03:15 INFO - Http code: 200 12:03:15 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 12:03:15 INFO - x-amz-cf-id: tiih9UFCS5uLMqHQegE0siG50Z4hTa5BLM-gMBPIqOUtcGtJU677SA== 12:03:15 INFO - x-amz-version-id: 5Js1aRXMD0moI4okjQdtw0kmfVbez.HC 12:03:15 INFO - Expected file size: 20547860 12:03:15 INFO - Obtained file size: 20547860 12:03:19 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 12:03:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:03:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:03:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:03:20 INFO - Http code: 200 12:03:20 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 12:03:20 INFO - x-amz-cf-id: BELj980xXuI_r8HXqqRGdQIydYM4MtOlzz6FWiJM0nJkJCNyg0ohcg== 12:03:20 INFO - x-amz-version-id: 5Js1aRXMD0moI4okjQdtw0kmfVbez.HC 12:03:20 INFO - Expected file size: 20547860 12:03:20 INFO - Obtained file size: 20547860 12:03:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:03:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:03:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:03:25 INFO - Http code: 200 12:03:25 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 12:03:25 INFO - x-amz-cf-id: O4wR-l7FRK7R6_ovRbn6fnHn5IevySP1LhzqVog_lI-8Dxg8ggK30g== 12:03:25 INFO - x-amz-version-id: .558HftH5Kbr.2yYwCIGwyftG0UaCeyn 12:03:25 INFO - Expected file size: 14409006 12:03:25 INFO - Obtained file size: 14409006 12:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:26 INFO - trying https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:03:26 INFO - Downloading https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/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 12:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/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 12:03:27 INFO - Downloaded 55930348 bytes. 12:03:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:03:27 INFO - mkdir: /builds/slave/test/properties 12:03:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:03:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:03:27 INFO - Contents: 12:03:27 INFO - build_url:https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:03:27 INFO - Running post-action listener: _resource_record_post_action 12:03:27 INFO - Running post-action listener: set_extra_try_arguments 12:03:27 INFO - [mozharness: 2016-10-12 19:03:27.861299Z] Finished download-and-extract step (success) 12:03:27 INFO - [mozharness: 2016-10-12 19:03:27.861601Z] Running populate-webroot step. 12:03:27 INFO - Running pre-action listener: _resource_record_pre_action 12:03:27 INFO - Running main action method: populate_webroot 12:03:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:03:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:03:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:03:27 INFO - '--tppagecycles', 12:03:27 INFO - '7'], 12:03:27 INFO - 'tests': ['tsvgm']}}, 12:03:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:03:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:03:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:03:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:03:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['damp', 'tps']}, 12:03:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'tests': ['damp', 'tps']}, 12:03:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['dromaeo_dom']}, 12:03:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:03:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['basic_compositor_video']}, 12:03:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:03:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['a11yr', 12:03:27 INFO - 'ts_paint', 12:03:27 INFO - 'tpaint', 12:03:27 INFO - 'sessionrestore', 12:03:27 INFO - 'sessionrestore_no_auto_restore', 12:03:27 INFO - 'tabpaint']}, 12:03:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['tsvgx', 12:03:27 INFO - 'tsvgr_opacity', 12:03:27 INFO - 'tart', 12:03:27 INFO - 'tscrollx', 12:03:27 INFO - 'cart']}, 12:03:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:03:27 INFO - 'tsvgr_opacity', 12:03:27 INFO - 'tart', 12:03:27 INFO - 'tscrollx', 12:03:27 INFO - 'cart']}, 12:03:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'talos_options': ['--disable-e10s'], 12:03:27 INFO - 'tests': ['tp5o']}, 12:03:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'tests': ['tp5o']}, 12:03:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'talos_options': ['--disable-e10s', 12:03:27 INFO - '--xperf_path', 12:03:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:27 INFO - 'tests': ['tp5n']}, 12:03:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:27 INFO - 'talos_options': ['--xperf_path', 12:03:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:27 INFO - 'tests': ['tp5n']}}, 12:03:27 INFO - 'talos.zip': {'path': '', 12:03:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:03:27 INFO - Running post-action listener: _resource_record_post_action 12:03:27 INFO - [mozharness: 2016-10-12 19:03:27.878661Z] Finished populate-webroot step (success) 12:03:27 INFO - [mozharness: 2016-10-12 19:03:27.878756Z] Running create-virtualenv step. 12:03:27 INFO - Running pre-action listener: _resource_record_pre_action 12:03:27 INFO - Running main action method: create_virtualenv 12:03:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:03:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:03:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:03:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:03:27 INFO - Using real prefix '/usr' 12:03:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:03:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:03:30 INFO - Installing pip.................done. 12:03:30 INFO - Return code: 0 12:03:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:03:30 INFO - Reading from file tmpfile_stdout 12:03:30 INFO - Output received: 12:03:30 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) 12:03:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:30 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:03:30 INFO - Using env: {'DISPLAY': ':0', 12:03:30 INFO - 'HOME': '/home/cltbld', 12:03:30 INFO - 'LANG': 'en_US.UTF-8', 12:03:30 INFO - 'LANGUAGE': 'en_US:en', 12:03:30 INFO - 'LOGNAME': 'cltbld', 12:03:30 INFO - 'MAIL': '/var/mail/cltbld', 12:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:30 INFO - 'MOZ_NO_REMOTE': '1', 12:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:30 INFO - 'NO_EM_RESTART': '1', 12:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:30 INFO - 'PWD': '/builds/slave/test', 12:03:30 INFO - 'SHELL': '/bin/bash', 12:03:30 INFO - 'SHLVL': '1', 12:03:30 INFO - 'TERM': 'linux', 12:03:30 INFO - 'TMOUT': '86400', 12:03:30 INFO - 'USER': 'cltbld', 12:03:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:30 INFO - '_': '/tools/buildbot/bin/python'} 12:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:03:30 INFO - Cleaning up... 12:03:30 INFO - Return code: 0 12:03:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:30 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:03:30 INFO - Using env: {'DISPLAY': ':0', 12:03:30 INFO - 'HOME': '/home/cltbld', 12:03:30 INFO - 'LANG': 'en_US.UTF-8', 12:03:30 INFO - 'LANGUAGE': 'en_US:en', 12:03:30 INFO - 'LOGNAME': 'cltbld', 12:03:30 INFO - 'MAIL': '/var/mail/cltbld', 12:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:30 INFO - 'MOZ_NO_REMOTE': '1', 12:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:30 INFO - 'NO_EM_RESTART': '1', 12:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:30 INFO - 'PWD': '/builds/slave/test', 12:03:30 INFO - 'SHELL': '/bin/bash', 12:03:30 INFO - 'SHLVL': '1', 12:03:30 INFO - 'TERM': 'linux', 12:03:30 INFO - 'TMOUT': '86400', 12:03:30 INFO - 'USER': 'cltbld', 12:03:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:30 INFO - '_': '/tools/buildbot/bin/python'} 12:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:31 INFO - Downloading/unpacking psutil>=3.1.1 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:03:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:33 INFO - Installing collected packages: psutil 12:03:33 INFO - Running setup.py install for psutil 12:03:33 INFO - building 'psutil._psutil_linux' extension 12:03:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:03:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:03:33 INFO - building 'psutil._psutil_posix' extension 12:03:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:03:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:03:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:33 INFO - Successfully installed psutil 12:03:33 INFO - Cleaning up... 12:03:33 INFO - Return code: 0 12:03:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:03:33 INFO - Using env: {'DISPLAY': ':0', 12:03:33 INFO - 'HOME': '/home/cltbld', 12:03:33 INFO - 'LANG': 'en_US.UTF-8', 12:03:33 INFO - 'LANGUAGE': 'en_US:en', 12:03:33 INFO - 'LOGNAME': 'cltbld', 12:03:33 INFO - 'MAIL': '/var/mail/cltbld', 12:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:33 INFO - 'MOZ_NO_REMOTE': '1', 12:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:33 INFO - 'NO_EM_RESTART': '1', 12:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:33 INFO - 'PWD': '/builds/slave/test', 12:03:33 INFO - 'SHELL': '/bin/bash', 12:03:33 INFO - 'SHLVL': '1', 12:03:33 INFO - 'TERM': 'linux', 12:03:33 INFO - 'TMOUT': '86400', 12:03:33 INFO - 'USER': 'cltbld', 12:03:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:33 INFO - '_': '/tools/buildbot/bin/python'} 12:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:03:35 INFO - Installing collected packages: mozsystemmonitor 12:03:35 INFO - Running setup.py install for mozsystemmonitor 12:03:35 INFO - Successfully installed mozsystemmonitor 12:03:35 INFO - Cleaning up... 12:03:36 INFO - Return code: 0 12:03:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:03:36 INFO - Using env: {'DISPLAY': ':0', 12:03:36 INFO - 'HOME': '/home/cltbld', 12:03:36 INFO - 'LANG': 'en_US.UTF-8', 12:03:36 INFO - 'LANGUAGE': 'en_US:en', 12:03:36 INFO - 'LOGNAME': 'cltbld', 12:03:36 INFO - 'MAIL': '/var/mail/cltbld', 12:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:36 INFO - 'MOZ_NO_REMOTE': '1', 12:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:36 INFO - 'NO_EM_RESTART': '1', 12:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:36 INFO - 'PWD': '/builds/slave/test', 12:03:36 INFO - 'SHELL': '/bin/bash', 12:03:36 INFO - 'SHLVL': '1', 12:03:36 INFO - 'TERM': 'linux', 12:03:36 INFO - 'TMOUT': '86400', 12:03:36 INFO - 'USER': 'cltbld', 12:03:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:36 INFO - '_': '/tools/buildbot/bin/python'} 12:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:03:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:03:38 INFO - warning: no files found matching '*.txt' 12:03:38 INFO - no previously-included directories found matching 'build' 12:03:38 INFO - no previously-included directories found matching 'dist' 12:03:38 INFO - no previously-included directories found matching '.git*' 12:03:38 INFO - Installing collected packages: jsonschema, functools32 12:03:38 INFO - Running setup.py install for functools32 12:03:38 INFO - warning: no files found matching '*.txt' 12:03:38 INFO - no previously-included directories found matching 'build' 12:03:38 INFO - no previously-included directories found matching 'dist' 12:03:38 INFO - no previously-included directories found matching '.git*' 12:03:38 INFO - Successfully installed jsonschema functools32 12:03:38 INFO - Cleaning up... 12:03:38 INFO - Return code: 0 12:03:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:38 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:38 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 12:03:38 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 12:03:38 INFO - Using env: {'DISPLAY': ':0', 12:03:38 INFO - 'HOME': '/home/cltbld', 12:03:38 INFO - 'LANG': 'en_US.UTF-8', 12:03:38 INFO - 'LANGUAGE': 'en_US:en', 12:03:38 INFO - 'LOGNAME': 'cltbld', 12:03:38 INFO - 'MAIL': '/var/mail/cltbld', 12:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:38 INFO - 'MOZ_NO_REMOTE': '1', 12:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:38 INFO - 'NO_EM_RESTART': '1', 12:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:38 INFO - 'PWD': '/builds/slave/test', 12:03:38 INFO - 'SHELL': '/bin/bash', 12:03:38 INFO - 'SHLVL': '1', 12:03:38 INFO - 'TERM': 'linux', 12:03:38 INFO - 'TMOUT': '86400', 12:03:38 INFO - 'USER': 'cltbld', 12:03:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:38 INFO - '_': '/tools/buildbot/bin/python'} 12:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:03:38 INFO - Cleaning up... 12:03:38 INFO - Return code: 0 12:03:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:38 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:03:38 INFO - Using env: {'DISPLAY': ':0', 12:03:38 INFO - 'HOME': '/home/cltbld', 12:03:38 INFO - 'LANG': 'en_US.UTF-8', 12:03:38 INFO - 'LANGUAGE': 'en_US:en', 12:03:38 INFO - 'LOGNAME': 'cltbld', 12:03:38 INFO - 'MAIL': '/var/mail/cltbld', 12:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:38 INFO - 'MOZ_NO_REMOTE': '1', 12:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:38 INFO - 'NO_EM_RESTART': '1', 12:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:38 INFO - 'PWD': '/builds/slave/test', 12:03:38 INFO - 'SHELL': '/bin/bash', 12:03:38 INFO - 'SHLVL': '1', 12:03:38 INFO - 'TERM': 'linux', 12:03:38 INFO - 'TMOUT': '86400', 12:03:38 INFO - 'USER': 'cltbld', 12:03:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:38 INFO - '_': '/tools/buildbot/bin/python'} 12:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:40 INFO - Downloading blobuploader-1.2.4.tar.gz 12:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:03:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:03:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:41 INFO - Downloading docopt-0.6.1.tar.gz 12:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:03:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:03:41 INFO - Running setup.py install for blobuploader 12:03:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:03:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:03:41 INFO - Running setup.py install for requests 12:03:42 INFO - Running setup.py install for docopt 12:03:42 INFO - Successfully installed blobuploader requests docopt 12:03:42 INFO - Cleaning up... 12:03:42 INFO - Return code: 0 12:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:42 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:42 INFO - Using env: {'DISPLAY': ':0', 12:03:42 INFO - 'HOME': '/home/cltbld', 12:03:42 INFO - 'LANG': 'en_US.UTF-8', 12:03:42 INFO - 'LANGUAGE': 'en_US:en', 12:03:42 INFO - 'LOGNAME': 'cltbld', 12:03:42 INFO - 'MAIL': '/var/mail/cltbld', 12:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:42 INFO - 'MOZ_NO_REMOTE': '1', 12:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:42 INFO - 'NO_EM_RESTART': '1', 12:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:42 INFO - 'PWD': '/builds/slave/test', 12:03:42 INFO - 'SHELL': '/bin/bash', 12:03:42 INFO - 'SHLVL': '1', 12:03:42 INFO - 'TERM': 'linux', 12:03:42 INFO - 'TMOUT': '86400', 12:03:42 INFO - 'USER': 'cltbld', 12:03:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:42 INFO - '_': '/tools/buildbot/bin/python'} 12:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:42 INFO - Running setup.py (path:/tmp/pip-6BI_6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:42 INFO - Running setup.py (path:/tmp/pip-gHgPIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:42 INFO - Running setup.py (path:/tmp/pip-2uW35q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:42 INFO - Running setup.py (path:/tmp/pip-qazkwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:42 INFO - Running setup.py (path:/tmp/pip-cygl35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:42 INFO - Running setup.py (path:/tmp/pip-x5oEOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:43 INFO - Running setup.py (path:/tmp/pip-WnxBcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:43 INFO - Running setup.py (path:/tmp/pip-AF2wv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:43 INFO - Running setup.py (path:/tmp/pip-4UDgN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:43 INFO - Running setup.py (path:/tmp/pip-RKzRb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:43 INFO - Running setup.py (path:/tmp/pip-aGj6Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:43 INFO - Running setup.py (path:/tmp/pip-MZisu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:43 INFO - Running setup.py (path:/tmp/pip-Ow5YEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:43 INFO - Running setup.py (path:/tmp/pip-JaTH7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:43 INFO - Running setup.py (path:/tmp/pip-VzhkuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Running setup.py (path:/tmp/pip-m_babc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Running setup.py (path:/tmp/pip-O4_6DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:03:43 INFO - Running setup.py install for manifestparser 12:03:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:43 INFO - Running setup.py install for mozcrash 12:03:44 INFO - Running setup.py install for mozdebug 12:03:44 INFO - Running setup.py install for mozdevice 12:03:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozfile 12:03:44 INFO - Running setup.py install for mozhttpd 12:03:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozinfo 12:03:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozInstall 12:03:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozleak 12:03:44 INFO - Running setup.py install for mozlog 12:03:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for moznetwork 12:03:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozprocess 12:03:45 INFO - Running setup.py install for mozprofile 12:03:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozrunner 12:03:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozscreenshot 12:03:45 INFO - Running setup.py install for moztest 12:03:45 INFO - Running setup.py install for mozversion 12:03:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:45 INFO - Cleaning up... 12:03:45 INFO - Return code: 0 12:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:45 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:45 INFO - Using env: {'DISPLAY': ':0', 12:03:45 INFO - 'HOME': '/home/cltbld', 12:03:45 INFO - 'LANG': 'en_US.UTF-8', 12:03:45 INFO - 'LANGUAGE': 'en_US:en', 12:03:45 INFO - 'LOGNAME': 'cltbld', 12:03:45 INFO - 'MAIL': '/var/mail/cltbld', 12:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:45 INFO - 'MOZ_NO_REMOTE': '1', 12:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:45 INFO - 'NO_EM_RESTART': '1', 12:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:45 INFO - 'PWD': '/builds/slave/test', 12:03:45 INFO - 'SHELL': '/bin/bash', 12:03:45 INFO - 'SHLVL': '1', 12:03:45 INFO - 'TERM': 'linux', 12:03:45 INFO - 'TMOUT': '86400', 12:03:45 INFO - 'USER': 'cltbld', 12:03:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:45 INFO - '_': '/tools/buildbot/bin/python'} 12:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:45 INFO - Running setup.py (path:/tmp/pip-_Lr_7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:45 INFO - Running setup.py (path:/tmp/pip-2CCchr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:46 INFO - Running setup.py (path:/tmp/pip-h9UbWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:46 INFO - Running setup.py (path:/tmp/pip-E_Lq3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:46 INFO - Running setup.py (path:/tmp/pip-Nd1bQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 INFO - Running setup.py (path:/tmp/pip-ty8YiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 INFO - Running setup.py (path:/tmp/pip-GS7QLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 INFO - Running setup.py (path:/tmp/pip-7dAMjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:46 INFO - Running setup.py (path:/tmp/pip-BYdZfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:46 INFO - Running setup.py (path:/tmp/pip-FySzpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:46 INFO - Running setup.py (path:/tmp/pip-fvq_Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:46 INFO - Running setup.py (path:/tmp/pip-gdozFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:46 INFO - Running setup.py (path:/tmp/pip-XySali-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:46 INFO - Running setup.py (path:/tmp/pip-R_mvsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:46 INFO - Running setup.py (path:/tmp/pip-J_KOEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:46 INFO - Running setup.py (path:/tmp/pip-GxtKEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:47 INFO - Running setup.py (path:/tmp/pip-hOBZM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:49 INFO - Downloading blessings-1.6.tar.gz 12:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:03:49 INFO - Installing collected packages: blessings 12:03:49 INFO - Running setup.py install for blessings 12:03:49 INFO - Successfully installed blessings 12:03:49 INFO - Cleaning up... 12:03:49 INFO - Return code: 0 12:03:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:49 INFO - Reading from file tmpfile_stdout 12:03:49 INFO - Current package versions: 12:03:49 INFO - argparse == 1.2.1 12:03:49 INFO - blessings == 1.6 12:03:49 INFO - blobuploader == 1.2.4 12:03:49 INFO - docopt == 0.6.1 12:03:49 INFO - functools32 == 3.2.3-2 12:03:49 INFO - jsonschema == 2.5.1 12:03:49 INFO - manifestparser == 1.1 12:03:49 INFO - mozInstall == 1.12 12:03:49 INFO - mozcrash == 0.17 12:03:49 INFO - mozdebug == 0.1 12:03:49 INFO - mozdevice == 0.48 12:03:49 INFO - mozfile == 1.2 12:03:49 INFO - mozhttpd == 0.7 12:03:49 INFO - mozinfo == 0.9 12:03:49 INFO - mozleak == 0.1 12:03:49 INFO - mozlog == 3.4 12:03:49 INFO - moznetwork == 0.27 12:03:49 INFO - mozprocess == 0.23 12:03:49 INFO - mozprofile == 0.28 12:03:49 INFO - mozrunner == 6.12 12:03:49 INFO - mozscreenshot == 0.1 12:03:49 INFO - mozsystemmonitor == 0.3 12:03:49 INFO - moztest == 0.7 12:03:49 INFO - mozversion == 1.4 12:03:49 INFO - psutil == 3.1.1 12:03:49 INFO - requests == 1.2.3 12:03:49 INFO - wsgiref == 0.1.2 12:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:49 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')]} 12:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 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')]} 12:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:49 INFO - Using env: {'DISPLAY': ':0', 12:03:49 INFO - 'HOME': '/home/cltbld', 12:03:49 INFO - 'LANG': 'en_US.UTF-8', 12:03:49 INFO - 'LANGUAGE': 'en_US:en', 12:03:49 INFO - 'LOGNAME': 'cltbld', 12:03:49 INFO - 'MAIL': '/var/mail/cltbld', 12:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:49 INFO - 'MOZ_NO_REMOTE': '1', 12:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:49 INFO - 'NO_EM_RESTART': '1', 12:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:49 INFO - 'PWD': '/builds/slave/test', 12:03:49 INFO - 'SHELL': '/bin/bash', 12:03:49 INFO - 'SHLVL': '1', 12:03:49 INFO - 'TERM': 'linux', 12:03:49 INFO - 'TMOUT': '86400', 12:03:49 INFO - 'USER': 'cltbld', 12:03:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:49 INFO - '_': '/tools/buildbot/bin/python'} 12:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:03:49 INFO - Cleaning up... 12:03:49 INFO - Return code: 0 12:03:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:03:49 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')]} 12:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 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')]} 12:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 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 0x7fa0aea5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, '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': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:03:49 INFO - Using env: {'DISPLAY': ':0', 12:03:49 INFO - 'HOME': '/home/cltbld', 12:03:49 INFO - 'LANG': 'en_US.UTF-8', 12:03:49 INFO - 'LANGUAGE': 'en_US:en', 12:03:49 INFO - 'LOGNAME': 'cltbld', 12:03:49 INFO - 'MAIL': '/var/mail/cltbld', 12:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:49 INFO - 'MOZ_NO_REMOTE': '1', 12:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:49 INFO - 'NO_EM_RESTART': '1', 12:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:49 INFO - 'PWD': '/builds/slave/test', 12:03:49 INFO - 'SHELL': '/bin/bash', 12:03:49 INFO - 'SHLVL': '1', 12:03:49 INFO - 'TERM': 'linux', 12:03:49 INFO - 'TMOUT': '86400', 12:03:49 INFO - 'USER': 'cltbld', 12:03:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:49 INFO - '_': '/tools/buildbot/bin/python'} 12:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:03:49 INFO - Cleaning up... 12:03:49 INFO - Return code: 0 12:03:49 INFO - Running post-action listener: _resource_record_post_action 12:03:49 INFO - Running post-action listener: _start_resource_monitoring 12:03:49 INFO - Starting resource monitoring. 12:03:49 INFO - [mozharness: 2016-10-12 19:03:49.996853Z] Finished create-virtualenv step (success) 12:03:49 INFO - [mozharness: 2016-10-12 19:03:49.997357Z] Running install step. 12:03:49 INFO - Running pre-action listener: _resource_record_pre_action 12:03:49 INFO - Running main action method: install 12:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:50 INFO - Reading from file tmpfile_stdout 12:03:50 INFO - Detecting whether we're running mozinstall >=1.0... 12:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:03:50 INFO - Reading from file tmpfile_stdout 12:03:50 INFO - Output received: 12:03:50 INFO - Usage: mozinstall [options] installer 12:03:50 INFO - Options: 12:03:50 INFO - -h, --help show this help message and exit 12:03:50 INFO - -d DEST, --destination=DEST 12:03:50 INFO - Directory to install application into. [default: 12:03:50 INFO - "/builds/slave/test"] 12:03:50 INFO - --app=APP Application being installed. [default: firefox] 12:03:50 INFO - mkdir: /builds/slave/test/build/application 12:03:50 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'] 12:03:50 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 12:04:06 INFO - Reading from file tmpfile_stdout 12:04:06 INFO - Output received: 12:04:06 INFO - /builds/slave/test/build/application/firefox/firefox 12:04:06 INFO - Running post-action listener: _resource_record_post_action 12:04:06 INFO - [mozharness: 2016-10-12 19:04:06.871955Z] Finished install step (success) 12:04:06 INFO - [mozharness: 2016-10-12 19:04:06.872204Z] Running run-tests step. 12:04:06 INFO - Running pre-action listener: _resource_record_pre_action 12:04:06 INFO - Running main action method: run_tests 12:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:04:06 INFO - Python 2.7.3 12:04:06 INFO - Return code: 0 12:04:06 INFO - grabbing minidump binary from tooltool 12:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:04:06 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 0x18abf60>, '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 0x18acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ad1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:04:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:04:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:04:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:04:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:04:06 INFO - Return code: 0 12:04:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:04:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:04:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:04:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:04:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:04:06 INFO - Using env: {'DISPLAY': ':0', 12:04:06 INFO - 'HOME': '/home/cltbld', 12:04:06 INFO - 'LANG': 'en_US.UTF-8', 12:04:06 INFO - 'LANGUAGE': 'en_US:en', 12:04:06 INFO - 'LOGNAME': 'cltbld', 12:04:06 INFO - 'MAIL': '/var/mail/cltbld', 12:04:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:04:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:06 INFO - 'MOZ_NO_REMOTE': '1', 12:04:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:04:06 INFO - 'NO_EM_RESTART': '1', 12:04:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:06 INFO - 'PWD': '/builds/slave/test', 12:04:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:04:06 INFO - 'SHELL': '/bin/bash', 12:04:06 INFO - 'SHLVL': '1', 12:04:06 INFO - 'TERM': 'linux', 12:04:06 INFO - 'TMOUT': '86400', 12:04:06 INFO - 'USER': 'cltbld', 12:04:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313', 12:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:06 INFO - '_': '/tools/buildbot/bin/python'} 12:04:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:04:07 INFO - mozversion application_buildid: 20161012103646 12:04:07 INFO - mozversion application_changeset: e3a490dbfea76cf18008824f3a7a8675ad4c3fee 12:04:07 INFO - mozversion application_display_name: Nightly 12:04:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:04:07 INFO - mozversion application_name: Firefox 12:04:07 INFO - mozversion application_remotingname: firefox 12:04:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:04:07 INFO - mozversion application_vendor: Mozilla 12:04:07 INFO - mozversion application_version: 52.0a1 12:04:07 INFO - mozversion platform_buildid: 20161012103646 12:04:07 INFO - mozversion platform_changeset: e3a490dbfea76cf18008824f3a7a8675ad4c3fee 12:04:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:04:07 INFO - mozversion platform_version: 52.0a1 12:04:07 INFO - using testdate: 1476299047 12:04:07 INFO - actual date: 1476299047 12:04:07 INFO - starting webserver on 'localhost:58713' 12:04:07 INFO - SUITE-START | Running 2 tests 12:04:07 INFO - TEST-START | dromaeo_css 12:04:07 INFO - operating with platform_type : linux_ 12:04:07 INFO - Initialising browser for dromaeo_css test... 12:04:07 INFO - TEST-INFO | started process 15568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnB0bc/profile http://localhost:58713/getInfo.html) 12:04:11 INFO - PROCESS | 15568 | __metrics Screen width/height:1600/1200 12:04:11 INFO - PROCESS | 15568 | colorDepth:24 12:04:11 INFO - PROCESS | 15568 | Browser inner width/height: 1024/697 12:04:11 INFO - PROCESS | 15568 | __metrics 12:04:12 INFO - PROCESS | 15568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:04:12 INFO - PROCESS | 15568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:04:12 INFO - PROCESS | 15568 | console.error: PushService: 12:04:12 INFO - PROCESS | 15568 | stateChangeProcessEnqueue: Error transitioning state 12:04:12 INFO - PROCESS | 15568 | UnknownError 12:04:13 INFO - TEST-INFO | 15568: exit 0 12:04:13 INFO - Browser initialized. 12:04:13 INFO - Running cycle 1/1 for dromaeo_css test... 12:04:13 INFO - TEST-INFO | started process 15652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnB0bc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:25 INFO - PROCESS | 15652 | RSS: Main: 175054848 12:04:25 INFO - PROCESS | 15652 | 12:05:17 INFO - PROCESS | 15652 | 1476299117454 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:07:30 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58713/tests/dromaeo/cssquery-ext.html) 12:07:32 INFO - PROCESS | 15652 | RSS: Main: 336969728 12:07:32 INFO - PROCESS | 15652 | 12:10:35 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-ext.html (next: http://localhost:58713/tests/dromaeo/cssquery-jquery.html) 12:10:36 INFO - PROCESS | 15652 | RSS: Main: 271433728 12:10:36 INFO - PROCESS | 15652 | 12:13:38 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58713/tests/dromaeo/cssquery-mootools.html) 12:13:39 INFO - PROCESS | 15652 | RSS: Main: 220033024 12:13:39 INFO - PROCESS | 15652 | 12:16:41 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58713/tests/dromaeo/cssquery-prototype.html) 12:16:41 INFO - PROCESS | 15652 | RSS: Main: 221179904 12:16:41 INFO - PROCESS | 15652 | 12:19:45 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58713/tests/dromaeo/cssquery-yui.html) 12:19:45 INFO - PROCESS | 15652 | RSS: Main: 220540928 12:19:45 INFO - PROCESS | 15652 | 12:22:48 INFO - PROCESS | 15652 | Cycle 1(1): loaded http://localhost:58713/tests/dromaeo/cssquery-yui.html (next: http://localhost:58713/tests/dromaeo/cssquery-dojo.html) 12:22:49 INFO - PROCESS | 15652 | RSS: Main: 312324096 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | __start_tp_report 12:22:49 INFO - PROCESS | 15652 | _x_x_mozilla_page_load 12:22:49 INFO - PROCESS | 15652 | _x_x_mozilla_page_load_details 12:22:49 INFO - PROCESS | 15652 | |i|pagename|runs| 12:22:49 INFO - PROCESS | 15652 | |0;dojo.html;2562.807789415794;2581.9483610327784;2615.607658851173;2623.108143231302;2637.8021648376366;4604.263317869141;4675.649326300524;4733.053389322136;4752.215884379082;4754.619630429566;4704.929426058612;4721.929171062428;4752.976235118819;4788.42538895333;4810.44679861816;4235.512916014652;4322.222000039991;4374.147041326943;4389.297712366022;4395.05506316142;4410.647148228134;4432.3794668746405;4446.73319600825;4449.176902273073;4495.595396414322;4232.555581663912;4383.189110014658;4403.955960440387;4409.536998615147;4508.458984921814;4256.851010214658;4325.6106950374615;4332.826686932519;4375.606195442426;4400.053988392479;4344.174606824693;4347.500037495665;4355.73865568067;4387.890302742425;4414.09511050234;4714.669973101884;4723.385959825235;4740.9288860666775;4744.051189762027;4752.453467851206;4857.149998750205;4903.975480122613;4905.681130726492;5088.338515992934;5089.465606111342;5037.949620503785;5066.442691303953;5095.643304968654;5160.303359046518;5180.1452760294505;4747.501512341223;4758.95241047592;4768.880777980578;4769.2369220925175;4822.541858523435;5203.037438073893;5209.921851172236;5214.32213812202;5225.111731005738;5277.525022747971;4836.637252206098;4851.927221091686;4900.117978763857;4904.509549045139;4914.017196560702;5009.599232061426;5012.147934851084;5023.49765023502;5042.672226305279;5056.039352523009;5004.824831130893;5009.173486374781;5030.622703297267;5109.335786347751;5127.66670166438;4811.735354555533;4871.074495845778;5032.79868805251;5043.445221025684;5048.3184770056305;4231;4250.936235956463;4301.935470967938;4307.1601037797955;4310.28880234764;3727.347714150013;3728.2357116790995;3737.32728108943;3772.038130276817;3784.0729021389934;4281.957180428156;4380.62764665007;4403.515613282536;4415.911681766347;4448.733076015449;4998.550130488274;5012.122878496249;5066.949330506722;5068.797248110108;5089.465606111305;4368.650507959355;4369.60673539383;4371.934420983688;4395.846145384896;4425.734455932655;4565.748883811356;4567.566081222279;4573.954260457353;4574.336721175478;4630.930536041962;4578.931316030195;4613.469451013177;4623.029163875623;4735.455422626442;4740.431148262231;5088.491150884882;5117.078925793393;5120.257562653469;5171.095058364695;5177.223416487557;4754.928676069792;4774.618030557477;4777.355057067251;4786.856394308176;4847.61219102478;4753.6434767393275;4782.760861956958;5032.597392208541;5033.446320904771;5068.391792984866;5063.265826455217;5086.771095300646;5109.8722531937;5118.8976220476125;5193.350831146106;4968.652194346361;4980.078685443204;4985.900281994267;4989.226669866177;5009.574186194069;4716.622670186445;4923.8276660316715;4982.227754698028;4984.950150498448;5042.218456139304;4701.694389864648;4754.7147171169845;4769.332293478985;4770.618350532019;4866.7079975201605;4965.503449655005;4999.425066117443;5004.3494345734825;5007.198848184273;5070.062038522738;4730.148573256709;4749.786259618257;4763.54746299101;4805.831795887128;4811.615070794258 12:22:49 INFO - PROCESS | 15652 | |1;ext.html;568.136432622414;569.8489900176454;570.7146426786607;573.6242760991552;578.0895090232884;27066;37322;38768.22463550727;38802.80598597003;41893;39286.41070383939;39680.404793928115;39745.60254397455;39776.602233977654;39874.20251594966;7503.962480187605;7641.923580764204;7675.270849269311;7679.462437629368;7681.6927322907295;7512.173660897297;7608.543487390747;7614.124375696782;7614.657340419667;7616.771496855075;7636.121845987727;7683.193264707209;7695.345895598881;7696.538207707556;7703.037120359955;7545.283198096199;7573.772786816405;7579.583122928237;7581.355584775273;7584.810379740496;7569.583672897988;7642.312191902755;7644.923550764533;7655;7655.732049378245;35044;35328;35366.29267414663;35382.46926296107;35403;3058.1284333964713;3059.35753491767;3079.1532328609587;3362.7982321060813;3666.0834791302173;26977.32556686079;27308;27780.16659500218;28468.145955621363;28831.711682883113;2919.5036843736616;2943.3230357018006;2997.7901546891726;3051.5422686596967;3054.563492063492;169264;170163;171362.14318928326;171730;173189.13405433018;30442;31450.21374465611;50438;50680.746596266785;50787.746061269456;33021.50467742986;33246.335073298396;33268.83365583205;33281.334373312886;33286.50070248948;12199.756004879853;12235.449404776806;12247.938760306142;12249.203801752858;12250.877491224974;10475.94762026185;10522;10527.94736026315;10530.05229529346;10542.789144217226;7804.3366313862825;7813.921860781319;7842.8431431371055;7888.092869320101;7900.249476299742;3107.90676279712;3126.7498600111935;3147.874085036573;3184.14028212386;3186.9043928682177;827.0654160798259;879.8680197970356;908.7591788176138;919.2278486071598;960.1934375124929;23320;23368.766312337;24026.639600406008;24270.87864560666;24674.753252467246;913.9588718507683;942.9387089839275;966.9806603868024;1037.1443559063803;1067.8771941226858;13477.393517291745;13672.794908076386;13700.725985480234;13781.793273100911;13926.234057126752;347583;350314;350540;351037;353243;31844.522332165037;32016.199595010312;32123;32361.676383236336;32423.51364729531;1026.4867566216892;1069.9572017119228;1156.2946602572592;1171.7715045566204;1186.483879512415;25318.746812532376;28638.427231454836;29124.7087529122;29140;29225.7077429223;39910;40420;40453.1909361817;40453.79773101116;40495;270015;270304;270620;270792;271687;24705.382365441008;24949.126780562594;25031.624525631767;25203.613801241107;25211;39857.20285594214;40254.39618405668;40540.1891962165;40848.38727419032;41238;33642.49536256909;34165.31669366549;34326.141846453036;34389;34459.31081378408;33858.8307058473;34256.82871585626;34287.314253714285;34554.481682774276;35247.83162946423;27025.86487067552;28394.98788839343;34049.65950340465;34266.31467370688;34278.48582271218;25103.87448062748;30403.2399190022;31798;32014.210014487235;32031;24078;24659.731746322755;24732.258032259062;24738.628920566567;24777 12:22:49 INFO - PROCESS | 15652 | |2;jquery.html;345.1888063051827;362.4635539401687;372.0401364479643;372.68135743938933;380.376183059782;12244.938775306122;12694.492220311187;16146.354145834168;16173.514794556153;17097.57256068596;16128.435504757335;16432.17839108046;16464.917675411605;16574.17684054753;16765.245563949622;4785.808567657289;4800.231962885939;4938.827141050073;5180.533751962323;5180.6373553851245;4939.456659767423;5073.84778456645;5075.822346217883;5075.9492405076035;5084.669496482736;4898.951010489903;5062.822801201959;5070.138076527;5072.137736584771;5082;5068.619853510983;5143.382794064718;5144.897102057937;5147.613928955343;5149.665271757323;4409.9559004410185;4601.4248218972625;4608.677392582521;4610.815567377301;4613.515580863995;19790.307339243056;19931.50171245716;20056;20340.288089916783;20347.389578312675;1859.3823373664864;1963.6759934610773;2251.1783199132365;2339.520398318358;2439.329184474284;12373.381330933418;12861.807072893915;12969.351532423436;13066;13355.544648213488;1667.1997441228277;1703.633718750462;1725.2150271626506;1745.197209283731;1755.3417468449331;67509.9999999995;68204;68226.65886670534;68378.65810670915;68996.3100368995;8110.513369197867;8725.476471411608;8778.95610521956;8824.95587522071;8935.687250946186;11631.941840290745;11676.532938682527;11680.415979201176;11685.298882067103;11707;6513.316101809241;6739.528233023641;6780.084688567079;6883;6945.687444065029;6551.770688025897;6664.366885145903;6879.174499060145;6931.445484361239;6947.89578156328;3722.3671975764187;3741.8503259869844;3754.3805272129794;3805.771653700787;3829.9617003829603;1782.5721826761485;1784.164047298319;1784.2773676660972;1853.2209079283768;1874.4282993687057;783.5142211828703;820.1716266570807;858.8539948208819;913.8720579118929;940.210223412337;16511.669766604602;16517.83482165187;17197.828021719874;17366;17579.384721534683;806.338802182205;835.4486039214089;853.7652145659994;871.779508687842;884.7036242858586;9114.453132812052;9308.581113849894;9764.755881103029;9771.413715177112;9944.900550994542;391902;391932.2505011728;399920.0075992776;401517;410634;76144.61927690326;79083;83199.16800831915;83465.58267208625;84770.5761471201;900.2033200617501;930.8929473110679;932.9440233586007;935.8362286599681;937.9718608441758;14295.714085718435;14383.352749126523;14396.712065758416;14631.561053168421;15139.394424223348;37277.25445491129;37547.249055019296;38278.808605956794;38532.42201366926;38804.80597597107;51238;53547.46452535425;53962;54289.72855135699;54399;7390.5196162249285;7651.502652327804;7699.88450173259;7720.845583088195;8024.478408903403;8704.695335663222;10887.673369798918;11068.5572577096;11909.76180476403;12035.277883327028;10023.298369114384;10055.29612927088;10281.74295642615;10334.793304133726;10720.142388609049;9655.372400793925;10152.644657436955;10287.382757034602;10489.895101048893;10618;9907.900920990985;9994.650187243702;10402.531886064993;10500.422476763852;10514.369137851754;7359.411247100326;7404.629768511661;7536.623168841426;7551.622418878924;7623.161452240138;9063.773405664648;10032.147267482054;10177.84733229017;10278.383297002203;10757.569697212024 12:22:49 INFO - PROCESS | 15652 | |3;mootools.html;1243.4466662335265;1365.7951307303904;1366.3646404421943;1428.8356838963516;1675.3466148202203;6592.4396426303765;7414.406847452205;7681.923180768191;7684.884726729104;7963.124056353797;7781.2996830285265;7830.9216907830905;7832.295093441589;7837.764867053983;7850.568218747967;2168.9566208675815;2187.5515519318583;2195.19875245535;2196.1325276515768;2196.6814811852273;2154.396768904709;2174.7281589801273;2226.7105276314055;2230.29745630126;2236.709227800392;2164.1235299703644;2180.607490651682;2184.14818220894;2187.168875827191;2208.381653137124;2126.1920470221294;2137.7969092936146;2138.786121387864;2139.5399989002285;2140;2083.864548804338;2132.061892767193;2134.0396821430263;2135.8077773000505;2141.100737690174;7479.962600186965;7520.548767073993;7616.961915190389;7617;7619.504732192389;4556.931646025312;4776.044791041771;4783.402074740658;4786.617070634341;4788.832390866303;2651.7613414792763;2792.218178909888;2832.107886015898;2866.426714657077;2874.9712502874913;856.0326830681353;865.2558799432483;865.8398196333699;1648.2994727240875;1649.043554738261;10237.795244095076;10266.435346055963;10283.79432411355;10376.63681771142;10456.37261764289;3797.2974999625158;3884.514435695538;4003.659688926474;4026.094128820992;4227.365895115758;8377.49735015901;8396.202360775716;8396.622152003174;8398.706045288507;8401.453905496122;4558.8632341029825;4566.703164294377;4574.199515084847;4598.586127248564;4608.377868987711;3577.141486043331;3730.403135498307;4080;4177.916441671149;4190.182914331676;3321.534985102088;3365.3269346130874;3478.0783092480515;3481.808500532444;3502.176988407722;981.764376549623;987.8123156600367;992.3153024413132;993.1855878179823;1030.7732298894232;833.1751565949787;846.5851732650957;851.67210623909;879.6393478673713;885.6236099657749;5109.284700141909;5163.251328557413;5205.490407781701;5236.319278493847;5249.133892907704;404.14926579549626;408.48530851127197;412.5152945289273;414.34947133001504;867.4101610904519;3719.442083687414;3857.4213867919475;3873.5932727063814;3893.2213557288655;3945.1320709443876;9278.072192780668;9598.040195980346;9667.564959576835;9678;9696.175825054808;9631.518424078908;9647.71056868295;9647.951760241154;9651.90348096524;9665.90334096664;6960.686769095403;7230.710771569184;7256;7431.8142046449275;7442.06974128234;5452.400235974119;5537.916931246115;5593.356763972032;5682.176084467812;5741.799037033684;8456.365772567206;8623.094575069528;8666.869996950178;8695.565221738761;8748.562571871254;8800.075992020746;8950.194482496347;8953.865692014755;9073.863892041492;9089.045650206634;5827.94172058274;6025.849353766191;6479.449246814073;6615.073889655549;6644.235912870082;6960.303969602999;7209.0628218331285;7220.819479513054;7372.336489715952;7382.630868456663;6560.573562718408;6682.866342673216;6701.363370479797;6711.429528490133;6851.3491218334175;6291.496680265476;6320.273168585672;6330.683465826598;6352.428281454507;6368.044793281045;6194;6294.590851594632;6310.432061114522;6312.368763123651;6314.179156709598;4609.562091601292;4743.478217396153;4804.327394164749;4823.686460380064;4829.44461386945;4474.709143905636;4523.547645235451;4569.840055598038;4702.600278976189;4737.928931065968 12:22:49 INFO - PROCESS | 15652 | |4;prototype.html;295.61569959053224;296.0629607292918;303.23584566891435;304.415522197381;307.6554259229663;4556.4760052593965;4708.670393072478;4793.304970779235;4823.421189457265;4832.106060378828;4562.452505699321;4642.558956899097;4681.789319480623;4705.988212534305;4745.928811067837;3758.5489741230954;3759;3775.49030880831;3792.810359482015;3793.7154713396467;3768.8304026318883;3789.658930696237;3793.867214647488;3798.8480460781534;3809.847606095753;3635.7273204509634;3751.1372384351616;3772.3964165733487;3773.52830896138;3793.5068441102617;3743.7005039596766;3762.9811850940846;3763.5483741951143;3771.679407250387;3774.9811250943844;3352.5641666583188;3352.932941341184;3355.8154301513405;3359.1266270769534;3366.343563005215;4506.81972721094;4639.30410438437;4661.46393164787;4666.2767271073035;4702.482726900038;4265.317549192146;4282.72162309452;4283.186194623012;4290.806913688892;4295.463067116611;4985.35190425246;4988.87527811804;5001.374828146481;5010.7494625268955;5017.147084995559;3659.963400365989;3666.2667466506537;3675.206842799492;3676.6690997810324;3682.416560878821;5019.046381187599;5215.817446389358;5217.660852044567;5219.739013049332;5245.4754524547625;3737.9626203738158;3740.4202348636004;3744.2698673758355;3746.269477451871;3755.2864955658883;3788.659020688096;3789.488419063446;3802.2775672622115;3809.790461524643;3831.080540670275;4075.286824805647;4253.723507971972;4308.418363520947;4316.740995540277;4324.070324880166;4992.176290911959;4999.75001249936;5007.3240112584335;5011.473795251446;5078.542931136216;1243.8445194350707;1269.942852571618;1273.6815796050987;1298.571471414431;1318.4792007157118;895.5343221524901;903.4985583001366;921.8156368726281;925.4169872979979;927.5825878354767;4374.212641724456;4379.912401751947;4391.956080439219;4413.278821259712;4420.778961051935;5090.41460232078;5096.61775366849;5100.2349647553165;5112.335396398445;5115.335006449138;4374.4531933508315;4384.539623339503;4389.539098394623;4391.692581519327;4410.3825464435;2323.93028209154;2378.8590268758257;2390.6414037894106;2397.386848335323;2411.854369174628;4214.620684138442;4238.131183107455;4246.3842742802735;4262.2754131797665;4280.72175308604;4568.109218702388;4598.678092533491;4603.9079218415445;4611.377464042378;4624.699394539344;4027.777777777766;4227.915441691211;4240.618344349024;4251.936220956688;4252.532221455637;4431.316099882024;4484.955150448453;4507.2421755514715;4512;4522.3442600823355;4384.903774056486;4395.582419670126;4414.889627759332;4426.826890873986;4436.268015777489;4019.4774679291504;4221.662267018693;4225.894352641209;4236.293243412015;4260.7017508775325;3344.648811874718;3347.230137068537;3373.4602463605706;3396.303757729709;3416.760826742104;4522.909541809079;4539.776758501501;4549.567791059844;4571.337156112411;4917.164082106122;4748.976255118702;4914.778834952364;4972.552470277692;5010.273510340907;5037.017781532566;4978.178600530872;4981.651284410056;4985.177445721415;4991.775370108281;4992.176290911959;4799.28010798383;4910.656254062182;4931.890324677062;4980.153373926369;4986.900261994812;4985.3020577118505;4988.351514303117;5012.674176178537;5022.388358053719;5028.547430731252;4916.434610019894;4917.704937703606;4933.309336692794;4948.604111671129;4955.45489996093 12:22:49 INFO - PROCESS | 15652 | |5;yui.html;636.4399328590839;670.249320760748;693.9791806245809;717.1824120502624;732.2092140488271;11442.828357574643;12424.130310878241;12437.253764774108;12445.937770311159;12453.937730311347;12078.637640870766;12200.75598488032;12211.328376939266;12213.328266945337;12273.079519036064;742.595285569366;764.678834889345;765.3456294867891;767.3324207939073;772.5828052851454;747.7868807389895;749.6139488163573;749.9775006749807;750.6359415683389;751.2337415835872;790.4940837863771;790.5414859381574;791.3471386106456;791.5804623549528;792.5205250823255;787.8503084413971;790.0716657926913;790.7548659915444;795.1134485049187;796.5897562755185;589.3929252869551;590.6190507122882;590.8197999610118;590.8581940334332;590.8936391449537;10885.510152043176;10900.727481812939;10908.563657453693;10915.508802103925;10918.454077296103;10201.489925503694;10581.576736930514;10679.893201068046;10750.139988800955;11223.943880280547;9272.582733776997;9352.859707104399;9466;9572.090651388107;9654.903450965541;3043.1479185828002;3067.4631939410515;3071.7389021933163;3105.5652208690576;3112.59536260287;56820;57066.42933570694;57868.71065644687;58186.41813581852;58938.11592826068;7672.1560628330835;7692.153863075057;7742.10965738936;7776.377889768805;7859.174786647434;15533;15541;15568.532944011698;15592.766108508382;15637.921810390875;6339.778107766206;6456.160699109179;6633.336666333328;6654.500912431587;6844.041834143224;3471.062813040465;3602.6757591816863;3648.7993160375904;3653.5250417446096;3685.539307586552;2884.293348129722;2976.255936015996;2996.0076549095043;2998.7301142897245;3005.2637103909683;480.51708033426183;480.89420327527887;483.38368580060705;485.3738677106564;489.9142650036229;479.2499737910229;496.84846121932435;553.3581045986637;565.2425749495613;572.9457797652257;7304.5252058616015;7719.575423351657;7743.457957943003;7801.960990195126;7807.609619519001;506.25074889164244;516.2488579117376;557.8967890940189;580.1674596953385;588.8321828279005;3523.894283171509;3774.7735135891385;3832.3868181091448;3984.083660758042;4050.635442810102;90375;96902;98577;99580.50209748905;99932;85965;86919;86941.5652921744;87306.56346718226;87841;72732;73772;74006.62996684982;74160.62919685367;77843;7061.682224299816;7194.388476979515;7232.493725439169;7290.781276561712;7334.229905860021;43293.134137317706;44354;44571.777141114086;44701.776491117336;45030.324545132506;38428.80785596054;39485.605143948196;46757.532424675315;53201.7339913298;56036;10628.25602207838;10810.67567972962;10895.400752958663;11426.314421134759;11655.475503602189;11843.881561184622;12053.337066461429;12436.502539898303;12803.871961280269;13432.731345372842;11082.294958166844;11618.128640351839;12211.816822747844;12364.81274107254;12472.87527124717;11268.267562608404;11512.079033677119;11893.46479408446;11926.403679815801;12059.939700301442;11004.834927476255;11679.824802627798;12126.27242365461;12225.938870305592;12240.632781016584;9158.542072896462;9789.167920726533;9811.901880981384;9931.155851752394;9986.950065249628;9053.59258833341;9457.952710236405;9933.3543319684;10002.899971000197;10036.799264014533 12:22:49 INFO - PROCESS | 15652 | __end_tp_report 12:22:49 INFO - PROCESS | 15652 | __start_cc_report 12:22:49 INFO - PROCESS | 15652 | _x_x_mozilla_cycle_collect,1810 12:22:49 INFO - PROCESS | 15652 | __end_cc_report 12:22:49 INFO - PROCESS | 15652 | __startTimestamp1476300169082__endTimestamp 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | ------- Summary: start ------- 12:22:49 INFO - PROCESS | 15652 | Number of tests: 6 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#0] dojo.html Cycles:165 Average:4673.40 Median:4763.55 stddev:491.93 (10.3%) stddev-sans-first:464.75 12:22:49 INFO - PROCESS | 15652 | Values: 2562.8 2581.9 2615.6 2623.1 2637.8 4604.3 4675.6 4733.1 4752.2 4754.6 4704.9 4721.9 4753.0 4788.4 4810.4 4235.5 4322.2 4374.1 4389.3 4395.1 4410.6 4432.4 4446.7 4449.2 4495.6 4232.6 4383.2 4404.0 4409.5 4508.5 4256.9 4325.6 4332.8 4375.6 4400.1 4344.2 4347.5 4355.7 4387.9 4414.1 4714.7 4723.4 4740.9 4744.1 4752.5 4857.1 4904.0 4905.7 5088.3 5089.5 5037.9 5066.4 5095.6 5160.3 5180.1 4747.5 4759.0 4768.9 4769.2 4822.5 5203.0 5209.9 5214.3 5225.1 5277.5 4836.6 4851.9 4900.1 4904.5 4914.0 5009.6 5012.1 5023.5 5042.7 5056.0 5004.8 5009.2 5030.6 5109.3 5127.7 4811.7 4871.1 5032.8 5043.4 5048.3 4231.0 4250.9 4301.9 4307.2 4310.3 3727.3 3728.2 3737.3 3772.0 3784.1 4282.0 4380.6 4403.5 4415.9 4448.7 4998.6 5012.1 5066.9 5068.8 5089.5 4368.7 4369.6 4371.9 4395.8 4425.7 4565.7 4567.6 4574.0 4574.3 4630.9 4578.9 4613.5 4623.0 4735.5 4740.4 5088.5 5117.1 5120.3 5171.1 5177.2 4754.9 4774.6 4777.4 4786.9 4847.6 4753.6 4782.8 5032.6 5033.4 5068.4 5063.3 5086.8 5109.9 5118.9 5193.4 4968.7 4980.1 4985.9 4989.2 5009.6 4716.6 4923.8 4982.2 4985.0 5042.2 4701.7 4754.7 4769.3 4770.6 4866.7 4965.5 4999.4 5004.3 5007.2 5070.1 4730.1 4749.8 4763.5 4805.8 4811.6 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#1] ext.html Cycles:180 Average:40243.69 Median:18502.65 stddev:72307.65 (390.8%) stddev-sans-first:72449.13 12:22:49 INFO - PROCESS | 15652 | Values: 568.1 569.8 570.7 573.6 578.1 27066.0 37322.0 38768.2 38802.8 41893.0 39286.4 39680.4 39745.6 39776.6 39874.2 7504.0 7641.9 7675.3 7679.5 7681.7 7512.2 7608.5 7614.1 7614.7 7616.8 7636.1 7683.2 7695.3 7696.5 7703.0 7545.3 7573.8 7579.6 7581.4 7584.8 7569.6 7642.3 7644.9 7655.0 7655.7 35044.0 35328.0 35366.3 35382.5 35403.0 3058.1 3059.4 3079.2 3362.8 3666.1 26977.3 27308.0 27780.2 28468.1 28831.7 2919.5 2943.3 2997.8 3051.5 3054.6 169264.0 170163.0 171362.1 171730.0 173189.1 30442.0 31450.2 50438.0 50680.7 50787.7 33021.5 33246.3 33268.8 33281.3 33286.5 12199.8 12235.4 12247.9 12249.2 12250.9 10475.9 10522.0 10527.9 10530.1 10542.8 7804.3 7813.9 7842.8 7888.1 7900.2 3107.9 3126.7 3147.9 3184.1 3186.9 827.1 879.9 908.8 919.2 960.2 23320.0 23368.8 24026.6 24270.9 24674.8 914.0 942.9 967.0 1037.1 1067.9 13477.4 13672.8 13700.7 13781.8 13926.2 347583.0 350314.0 350540.0 351037.0 353243.0 31844.5 32016.2 32123.0 32361.7 32423.5 1026.5 1070.0 1156.3 1171.8 1186.5 25318.7 28638.4 29124.7 29140.0 29225.7 39910.0 40420.0 40453.2 40453.8 40495.0 270015.0 270304.0 270620.0 270792.0 271687.0 24705.4 24949.1 25031.6 25203.6 25211.0 39857.2 40254.4 40540.2 40848.4 41238.0 33642.5 34165.3 34326.1 34389.0 34459.3 33858.8 34256.8 34287.3 34554.5 35247.8 27025.9 28395.0 34049.7 34266.3 34278.5 25103.9 30403.2 31798.0 32014.2 32031.0 24078.0 24659.7 24732.3 24738.6 24777.0 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#2] jquery.html Cycles:180 Average:24556.39 Median:4505.69 stddev:66023.23 (1465.3%) stddev-sans-first:66183.41 12:22:49 INFO - PROCESS | 15652 | Values: 345.2 362.5 372.0 372.7 380.4 12244.9 12694.5 16146.4 16173.5 17097.6 16128.4 16432.2 16464.9 16574.2 16765.2 4785.8 4800.2 4938.8 5180.5 5180.6 4939.5 5073.8 5075.8 5075.9 5084.7 4899.0 5062.8 5070.1 5072.1 5082.0 5068.6 5143.4 5144.9 5147.6 5149.7 4410.0 4601.4 4608.7 4610.8 4613.5 19790.3 19931.5 20056.0 20340.3 20347.4 1859.4 1963.7 2251.2 2339.5 2439.3 12373.4 12861.8 12969.4 13066.0 13355.5 1667.2 1703.6 1725.2 1745.2 1755.3 67510.0 68204.0 68226.7 68378.7 68996.3 8110.5 8725.5 8779.0 8825.0 8935.7 11631.9 11676.5 11680.4 11685.3 11707.0 6513.3 6739.5 6780.1 6883.0 6945.7 6551.8 6664.4 6879.2 6931.4 6947.9 3722.4 3741.9 3754.4 3805.8 3830.0 1782.6 1784.2 1784.3 1853.2 1874.4 783.5 820.2 858.9 913.9 940.2 16511.7 16517.8 17197.8 17366.0 17579.4 806.3 835.4 853.8 871.8 884.7 9114.5 9308.6 9764.8 9771.4 9944.9 391902.0 391932.3 399920.0 401517.0 410634.0 76144.6 79083.0 83199.2 83465.6 84770.6 900.2 930.9 932.9 935.8 938.0 14295.7 14383.4 14396.7 14631.6 15139.4 37277.3 37547.2 38278.8 38532.4 38804.8 51238.0 53547.5 53962.0 54289.7 54399.0 7390.5 7651.5 7699.9 7720.8 8024.5 8704.7 10887.7 11068.6 11909.8 12035.3 10023.3 10055.3 10281.7 10334.8 10720.1 9655.4 10152.6 10287.4 10489.9 10618.0 9907.9 9994.7 10402.5 10500.4 10514.4 7359.4 7404.6 7536.6 7551.6 7623.2 9063.8 10032.1 10177.8 10278.4 10757.6 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#3] mootools.html Cycles:180 Average:5051.58 Median:5242.73 stddev:2814.60 (53.7%) stddev-sans-first:2807.94 12:22:49 INFO - PROCESS | 15652 | Values: 1243.4 1365.8 1366.4 1428.8 1675.3 6592.4 7414.4 7681.9 7684.9 7963.1 7781.3 7830.9 7832.3 7837.8 7850.6 2169.0 2187.6 2195.2 2196.1 2196.7 2154.4 2174.7 2226.7 2230.3 2236.7 2164.1 2180.6 2184.1 2187.2 2208.4 2126.2 2137.8 2138.8 2139.5 2140.0 2083.9 2132.1 2134.0 2135.8 2141.1 7480.0 7520.5 7617.0 7617.0 7619.5 4556.9 4776.0 4783.4 4786.6 4788.8 2651.8 2792.2 2832.1 2866.4 2875.0 856.0 865.3 865.8 1648.3 1649.0 10237.8 10266.4 10283.8 10376.6 10456.4 3797.3 3884.5 4003.7 4026.1 4227.4 8377.5 8396.2 8396.6 8398.7 8401.5 4558.9 4566.7 4574.2 4598.6 4608.4 3577.1 3730.4 4080.0 4177.9 4190.2 3321.5 3365.3 3478.1 3481.8 3502.2 981.8 987.8 992.3 993.2 1030.8 833.2 846.6 851.7 879.6 885.6 5109.3 5163.3 5205.5 5236.3 5249.1 404.1 408.5 412.5 414.3 867.4 3719.4 3857.4 3873.6 3893.2 3945.1 9278.1 9598.0 9667.6 9678.0 9696.2 9631.5 9647.7 9648.0 9651.9 9665.9 6960.7 7230.7 7256.0 7431.8 7442.1 5452.4 5537.9 5593.4 5682.2 5741.8 8456.4 8623.1 8666.9 8695.6 8748.6 8800.1 8950.2 8953.9 9073.9 9089.0 5827.9 6025.8 6479.4 6615.1 6644.2 6960.3 7209.1 7220.8 7372.3 7382.6 6560.6 6682.9 6701.4 6711.4 6851.3 6291.5 6320.3 6330.7 6352.4 6368.0 6194.0 6294.6 6310.4 6312.4 6314.2 4609.6 4743.5 4804.3 4823.7 4829.4 4474.7 4523.5 4569.8 4702.6 4737.9 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#4] prototype.html Cycles:180 Average:4031.58 Median:4390.62 stddev:1144.56 (26.1%) stddev-sans-first:1112.89 12:22:49 INFO - PROCESS | 15652 | Values: 295.6 296.1 303.2 304.4 307.7 4556.5 4708.7 4793.3 4823.4 4832.1 4562.5 4642.6 4681.8 4706.0 4745.9 3758.5 3759.0 3775.5 3792.8 3793.7 3768.8 3789.7 3793.9 3798.8 3809.8 3635.7 3751.1 3772.4 3773.5 3793.5 3743.7 3763.0 3763.5 3771.7 3775.0 3352.6 3352.9 3355.8 3359.1 3366.3 4506.8 4639.3 4661.5 4666.3 4702.5 4265.3 4282.7 4283.2 4290.8 4295.5 4985.4 4988.9 5001.4 5010.7 5017.1 3660.0 3666.3 3675.2 3676.7 3682.4 5019.0 5215.8 5217.7 5219.7 5245.5 3738.0 3740.4 3744.3 3746.3 3755.3 3788.7 3789.5 3802.3 3809.8 3831.1 4075.3 4253.7 4308.4 4316.7 4324.1 4992.2 4999.8 5007.3 5011.5 5078.5 1243.8 1269.9 1273.7 1298.6 1318.5 895.5 903.5 921.8 925.4 927.6 4374.2 4379.9 4392.0 4413.3 4420.8 5090.4 5096.6 5100.2 5112.3 5115.3 4374.5 4384.5 4389.5 4391.7 4410.4 2323.9 2378.9 2390.6 2397.4 2411.9 4214.6 4238.1 4246.4 4262.3 4280.7 4568.1 4598.7 4603.9 4611.4 4624.7 4027.8 4227.9 4240.6 4251.9 4252.5 4431.3 4485.0 4507.2 4512.0 4522.3 4384.9 4395.6 4414.9 4426.8 4436.3 4019.5 4221.7 4225.9 4236.3 4260.7 3344.6 3347.2 3373.5 3396.3 3416.8 4522.9 4539.8 4549.6 4571.3 4917.2 4749.0 4914.8 4972.6 5010.3 5037.0 4978.2 4981.7 4985.2 4991.8 4992.2 4799.3 4910.7 4931.9 4980.2 4986.9 4985.3 4988.4 5012.7 5022.4 5028.5 4916.4 4917.7 4933.3 4948.6 4955.5 12:22:49 INFO - PROCESS | 15652 | 12:22:49 INFO - PROCESS | 15652 | [#5] yui.html Cycles:180 Average:16828.54 Median:555.63 stddev:24750.11 (4454.4%) stddev-sans-first:24789.68 12:22:49 INFO - PROCESS | 15652 | Values: 636.4 670.2 694.0 717.2 732.2 11442.8 12424.1 12437.3 12445.9 12453.9 12078.6 12200.8 12211.3 12213.3 12273.1 742.6 764.7 765.3 767.3 772.6 747.8 749.6 750.0 750.6 751.2 790.5 790.5 791.3 791.6 792.5 787.9 790.1 790.8 795.1 796.6 589.4 590.6 590.8 590.9 590.9 10885.5 10900.7 10908.6 10915.5 10918.5 10201.5 10581.6 10679.9 10750.1 11223.9 9272.6 9352.9 9466.0 9572.1 9654.9 3043.1 3067.5 3071.7 3105.6 3112.6 56820.0 57066.4 57868.7 58186.4 58938.1 7672.2 7692.2 7742.1 7776.4 7859.2 15533.0 15541.0 15568.5 15592.8 15637.9 6339.8 6456.2 6633.3 6654.5 6844.0 3471.1 3602.7 3648.8 3653.5 3685.5 2884.3 2976.3 2996.0 2998.7 3005.3 480.5 480.9 483.4 485.4 489.9 479.2 496.8 553.4 565.2 572.9 7304.5 7719.6 7743.5 7802.0 7807.6 506.3 516.2 557.9 580.2 588.8 3523.9 3774.8 3832.4 3984.1 4050.6 90375.0 96902.0 98577.0 99580.5 99932.0 85965.0 86919.0 86941.6 87306.6 87841.0 72732.0 73772.0 74006.6 74160.6 77843.0 7061.7 7194.4 7232.5 7290.8 7334.2 43293.1 44354.0 44571.8 44701.8 45030.3 38428.8 39485.6 46757.5 53201.7 56036.0 10628.3 10810.7 10895.4 11426.3 11655.5 11843.9 12053.3 12436.5 12803.9 13432.7 11082.3 11618.1 12211.8 12364.8 12472.9 11268.3 11512.1 11893.5 11926.4 12059.9 11004.8 11679.8 12126.3 12225.9 12240.6 9158.5 9789.2 9811.9 9931.2 9987.0 9053.6 9458.0 9933.4 10002.9 10036.8 12:22:49 INFO - PROCESS | 15652 | -------- Summary: end -------- 12:22:49 INFO - PROCESS | 15652 | 12:22:50 INFO - TEST-INFO | 15652: exit 0 12:22:50 INFO - TEST-OK | dromaeo_css | took 1122937ms 12:22:50 INFO - TEST-START | kraken 12:22:50 INFO - operating with platform_type : linux_ 12:22:50 INFO - Initialising browser for kraken test... 12:22:50 INFO - TEST-INFO | started process 15966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqGrYWH/profile http://localhost:58713/getInfo.html) 12:22:54 INFO - PROCESS | 15966 | __metrics Screen width/height:1600/1200 12:22:54 INFO - PROCESS | 15966 | colorDepth:24 12:22:54 INFO - PROCESS | 15966 | Browser inner width/height: 1024/697 12:22:54 INFO - PROCESS | 15966 | __metrics 12:22:55 INFO - PROCESS | 15966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:22:55 INFO - PROCESS | 15966 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:55 INFO - PROCESS | 15966 | console.error: PushService: 12:22:55 INFO - PROCESS | 15966 | stateChangeProcessEnqueue: Error transitioning state 12:22:55 INFO - PROCESS | 15966 | UnknownError 12:22:56 INFO - TEST-INFO | 15966: exit 0 12:22:56 INFO - Browser initialized. 12:22:56 INFO - Running cycle 1/1 for kraken test... 12:22:56 INFO - TEST-INFO | started process 16045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqGrYWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:08 INFO - PROCESS | 16045 | RSS: Main: 174878720 12:23:08 INFO - PROCESS | 16045 | 12:23:11 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58713/tests/kraken/driver.html?testName=audio-beat-detection) 12:23:12 INFO - PROCESS | 16045 | RSS: Main: 232845312 12:23:12 INFO - PROCESS | 16045 | 12:23:15 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58713/tests/kraken/driver.html?testName=audio-dft) 12:23:15 INFO - PROCESS | 16045 | RSS: Main: 218079232 12:23:15 INFO - PROCESS | 16045 | 12:23:19 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58713/tests/kraken/driver.html?testName=audio-fft) 12:23:19 INFO - PROCESS | 16045 | RSS: Main: 300687360 12:23:19 INFO - PROCESS | 16045 | 12:23:21 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58713/tests/kraken/driver.html?testName=audio-oscillator) 12:23:22 INFO - PROCESS | 16045 | RSS: Main: 209039360 12:23:22 INFO - PROCESS | 16045 | 12:23:24 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:23:25 INFO - PROCESS | 16045 | RSS: Main: 213020672 12:23:25 INFO - PROCESS | 16045 | 12:23:28 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58713/tests/kraken/driver.html?testName=imaging-darkroom) 12:23:29 INFO - PROCESS | 16045 | RSS: Main: 249954304 12:23:29 INFO - PROCESS | 16045 | 12:23:32 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58713/tests/kraken/driver.html?testName=imaging-desaturate) 12:23:33 INFO - PROCESS | 16045 | RSS: Main: 243707904 12:23:33 INFO - PROCESS | 16045 | 12:23:36 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58713/tests/kraken/driver.html?testName=json-parse-financial) 12:23:36 INFO - PROCESS | 16045 | RSS: Main: 246874112 12:23:36 INFO - PROCESS | 16045 | 12:23:38 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:23:39 INFO - PROCESS | 16045 | RSS: Main: 210558976 12:23:39 INFO - PROCESS | 16045 | 12:23:40 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:23:41 INFO - PROCESS | 16045 | RSS: Main: 217747456 12:23:41 INFO - PROCESS | 16045 | 12:23:43 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:23:44 INFO - PROCESS | 16045 | RSS: Main: 226623488 12:23:44 INFO - PROCESS | 16045 | 12:23:47 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:48 INFO - PROCESS | 16045 | RSS: Main: 235364352 12:23:48 INFO - PROCESS | 16045 | 12:23:51 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:51 INFO - PROCESS | 16045 | RSS: Main: 232640512 12:23:51 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:58713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58713/tests/kraken/driver.html?testName=ai-astar) 12:23:53 INFO - PROCESS | 16045 | RSS: Main: 282677248 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | __start_tp_report 12:23:53 INFO - PROCESS | 16045 | _x_x_mozilla_page_load 12:23:53 INFO - PROCESS | 16045 | _x_x_mozilla_page_load_details 12:23:53 INFO - PROCESS | 16045 | |i|pagename|runs| 12:23:53 INFO - PROCESS | 16045 | |0;ai-astar;112;114;114;114;114;114;115;116;114;113 12:23:53 INFO - PROCESS | 16045 | |1;audio-beat-detection;153;127;125;172;130;131;129;142;165;132 12:23:53 INFO - PROCESS | 16045 | |2;audio-dft;163;162;164;162;161;162;162;162;160;160 12:23:53 INFO - PROCESS | 16045 | |3;audio-fft;76;75;75;107;76;76;76;76;117;74 12:23:53 INFO - PROCESS | 16045 | |4;audio-oscillator;83;82;112;83;83;84;116;83;83;111 12:23:53 INFO - PROCESS | 16045 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 12:23:53 INFO - PROCESS | 16045 | |6;imaging-darkroom;148;146;147;147;147;146;147;147;147;146 12:23:53 INFO - PROCESS | 16045 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;96;96 12:23:53 INFO - PROCESS | 16045 | |8;json-parse-financial;65;64;65;64;66;65;65;65;65;65 12:23:53 INFO - PROCESS | 16045 | |9;json-stringify-tinderbox;66;67;66;67;67;66;66;66;67;66 12:23:53 INFO - PROCESS | 16045 | |10;stanford-crypto-aes;89;86;84;90;83;98;89;83;83;83 12:23:53 INFO - PROCESS | 16045 | |11;stanford-crypto-ccm;141;139;143;139;138;146;142;137;180;143 12:23:53 INFO - PROCESS | 16045 | |12;stanford-crypto-pbkdf2;177;186;177;177;178;177;179;177;176;178 12:23:53 INFO - PROCESS | 16045 | |13;stanford-crypto-sha256-iterative;74;74;70;69;70;70;71;75;69;68 12:23:53 INFO - PROCESS | 16045 | __end_tp_report 12:23:53 INFO - PROCESS | 16045 | __start_cc_report 12:23:53 INFO - PROCESS | 16045 | _x_x_mozilla_cycle_collect,2000 12:23:53 INFO - PROCESS | 16045 | __end_cc_report 12:23:53 INFO - PROCESS | 16045 | __startTimestamp1476300233746__endTimestamp 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | ------- Summary: start ------- 12:23:53 INFO - PROCESS | 16045 | Number of tests: 14 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:0.83 12:23:53 INFO - PROCESS | 16045 | Values: 112.0 114.0 114.0 114.0 114.0 114.0 115.0 116.0 114.0 113.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:137.00 stddev:16.93 (12.4%) stddev-sans-first:17.35 12:23:53 INFO - PROCESS | 16045 | Values: 153.0 127.0 125.0 172.0 130.0 131.0 129.0 142.0 165.0 132.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 12:23:53 INFO - PROCESS | 16045 | Values: 163.0 162.0 164.0 162.0 161.0 162.0 162.0 162.0 160.0 160.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:15.58 (20.5%) stddev-sans-first:16.33 12:23:53 INFO - PROCESS | 16045 | Values: 76.0 75.0 75.0 107.0 76.0 76.0 76.0 76.0 117.0 74.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.55 (17.5%) stddev-sans-first:15.07 12:23:53 INFO - PROCESS | 16045 | Values: 83.0 82.0 112.0 83.0 83.0 84.0 116.0 83.0 83.0 111.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:23:53 INFO - PROCESS | 16045 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 12:23:53 INFO - PROCESS | 16045 | Values: 148.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:23:53 INFO - PROCESS | 16045 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:23:53 INFO - PROCESS | 16045 | Values: 65.0 64.0 65.0 64.0 66.0 65.0 65.0 65.0 65.0 65.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 12:23:53 INFO - PROCESS | 16045 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.50 stddev:4.85 (5.5%) stddev-sans-first:5.08 12:23:53 INFO - PROCESS | 16045 | Values: 89.0 86.0 84.0 90.0 83.0 98.0 89.0 83.0 83.0 83.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:142.50 stddev:12.66 (8.9%) stddev-sans-first:13.36 12:23:53 INFO - PROCESS | 16045 | Values: 141.0 139.0 143.0 139.0 138.0 146.0 142.0 137.0 180.0 143.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:177.50 stddev:2.86 (1.6%) stddev-sans-first:3.00 12:23:53 INFO - PROCESS | 16045 | Values: 177.0 186.0 177.0 177.0 178.0 177.0 179.0 177.0 176.0 178.0 12:23:53 INFO - PROCESS | 16045 | 12:23:53 INFO - PROCESS | 16045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:2.45 (3.5%) stddev-sans-first:2.35 12:23:53 INFO - PROCESS | 16045 | Values: 74.0 74.0 70.0 69.0 70.0 70.0 71.0 75.0 69.0 68.0 12:23:53 INFO - PROCESS | 16045 | -------- Summary: end -------- 12:23:53 INFO - PROCESS | 16045 | 12:23:55 INFO - TEST-INFO | 16045: exit 0 12:23:55 INFO - TEST-OK | kraken | took 65007ms 12:23:55 INFO - SUITE-END | took 1187s 12:23:55 INFO - Completed test suite (00:19:48) 12:23:55 INFO - javascript benchmark 12:23:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.807789415794, 2581.9483610327784, 2615.607658851173, 2623.108143231302, 2637.8021648376366, 4604.263317869141, 4675.649326300524, 4733.053389322136, 4752.215884379082, 4754.619630429566, 4704.929426058612, 4721.929171062428, 4752.976235118819, 4788.42538895333, 4810.44679861816, 4235.512916014652, 4322.222000039991, 4374.147041326943, 4389.297712366022, 4395.05506316142, 4410.647148228134, 4432.3794668746405, 4446.73319600825, 4449.176902273073, 4495.595396414322, 4232.555581663912, 4383.189110014658, 4403.955960440387, 4409.536998615147, 4508.458984921814, 4256.851010214658, 4325.6106950374615, 4332.826686932519, 4375.606195442426, 4400.053988392479, 4344.174606824693, 4347.500037495665, 4355.73865568067, 4387.890302742425, 4414.09511050234, 4714.669973101884, 4723.385959825235, 4740.9288860666775, 4744.051189762027, 4752.453467851206, 4857.149998750205, 4903.975480122613, 4905.681130726492, 5088.338515992934, 5089.465606111342, 5037.949620503785, 5066.442691303953, 5095.643304968654, 5160.303359046518, 5180.1452760294505, 4747.501512341223, 4758.95241047592, 4768.880777980578, 4769.2369220925175, 4822.541858523435, 5203.037438073893, 5209.921851172236, 5214.32213812202, 5225.111731005738, 5277.525022747971, 4836.637252206098, 4851.927221091686, 4900.117978763857, 4904.509549045139, 4914.017196560702, 5009.599232061426, 5012.147934851084, 5023.49765023502, 5042.672226305279, 5056.039352523009, 5004.824831130893, 5009.173486374781, 5030.622703297267, 5109.335786347751, 5127.66670166438, 4811.735354555533, 4871.074495845778, 5032.79868805251, 5043.445221025684, 5048.3184770056305, 4231.0, 4250.936235956463, 4301.935470967938, 4307.1601037797955, 4310.28880234764, 3727.347714150013, 3728.2357116790995, 3737.32728108943, 3772.038130276817, 3784.0729021389934, 4281.957180428156, 4380.62764665007, 4403.515613282536, 4415.911681766347, 4448.733076015449, 4998.550130488274, 5012.122878496249, 5066.949330506722, 5068.797248110108, 5089.465606111305, 4368.650507959355, 4369.60673539383, 4371.934420983688, 4395.846145384896, 4425.734455932655, 4565.748883811356, 4567.566081222279, 4573.954260457353, 4574.336721175478, 4630.930536041962, 4578.931316030195, 4613.469451013177, 4623.029163875623, 4735.455422626442, 4740.431148262231, 5088.491150884882, 5117.078925793393, 5120.257562653469, 5171.095058364695, 5177.223416487557, 4754.928676069792, 4774.618030557477, 4777.355057067251, 4786.856394308176, 4847.61219102478, 4753.6434767393275, 4782.760861956958, 5032.597392208541, 5033.446320904771, 5068.391792984866, 5063.265826455217, 5086.771095300646, 5109.8722531937, 5118.8976220476125, 5193.350831146106, 4968.652194346361, 4980.078685443204, 4985.900281994267, 4989.226669866177, 5009.574186194069, 4716.622670186445, 4923.8276660316715, 4982.227754698028, 4984.950150498448, 5042.218456139304, 4701.694389864648, 4754.7147171169845, 4769.332293478985, 4770.618350532019, 4866.7079975201605, 4965.503449655005, 4999.425066117443, 5004.3494345734825, 5007.198848184273, 5070.062038522738, 4730.148573256709, 4749.786259618257, 4763.54746299101, 4805.831795887128, 4811.615070794258], "value": 4641.66521798151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.136432622414, 569.8489900176454, 570.7146426786607, 573.6242760991552, 578.0895090232884, 27066.0, 37322.0, 38768.22463550727, 38802.80598597003, 41893.0, 39286.41070383939, 39680.404793928115, 39745.60254397455, 39776.602233977654, 39874.20251594966, 7503.962480187605, 7641.923580764204, 7675.270849269311, 7679.462437629368, 7681.6927322907295, 7512.173660897297, 7608.543487390747, 7614.124375696782, 7614.657340419667, 7616.771496855075, 7636.121845987727, 7683.193264707209, 7695.345895598881, 7696.538207707556, 7703.037120359955, 7545.283198096199, 7573.772786816405, 7579.583122928237, 7581.355584775273, 7584.810379740496, 7569.583672897988, 7642.312191902755, 7644.923550764533, 7655.0, 7655.732049378245, 35044.0, 35328.0, 35366.29267414663, 35382.46926296107, 35403.0, 3058.1284333964713, 3059.35753491767, 3079.1532328609587, 3362.7982321060813, 3666.0834791302173, 26977.32556686079, 27308.0, 27780.16659500218, 28468.145955621363, 28831.711682883113, 2919.5036843736616, 2943.3230357018006, 2997.7901546891726, 3051.5422686596967, 3054.563492063492, 169264.0, 170163.0, 171362.14318928326, 171730.0, 173189.13405433018, 30442.0, 31450.21374465611, 50438.0, 50680.746596266785, 50787.746061269456, 33021.50467742986, 33246.335073298396, 33268.83365583205, 33281.334373312886, 33286.50070248948, 12199.756004879853, 12235.449404776806, 12247.938760306142, 12249.203801752858, 12250.877491224974, 10475.94762026185, 10522.0, 10527.94736026315, 10530.05229529346, 10542.789144217226, 7804.3366313862825, 7813.921860781319, 7842.8431431371055, 7888.092869320101, 7900.249476299742, 3107.90676279712, 3126.7498600111935, 3147.874085036573, 3184.14028212386, 3186.9043928682177, 827.0654160798259, 879.8680197970356, 908.7591788176138, 919.2278486071598, 960.1934375124929, 23320.0, 23368.766312337, 24026.639600406008, 24270.87864560666, 24674.753252467246, 913.9588718507683, 942.9387089839275, 966.9806603868024, 1037.1443559063803, 1067.8771941226858, 13477.393517291745, 13672.794908076386, 13700.725985480234, 13781.793273100911, 13926.234057126752, 347583.0, 350314.0, 350540.0, 351037.0, 353243.0, 31844.522332165037, 32016.199595010312, 32123.0, 32361.676383236336, 32423.51364729531, 1026.4867566216892, 1069.9572017119228, 1156.2946602572592, 1171.7715045566204, 1186.483879512415, 25318.746812532376, 28638.427231454836, 29124.7087529122, 29140.0, 29225.7077429223, 39910.0, 40420.0, 40453.1909361817, 40453.79773101116, 40495.0, 270015.0, 270304.0, 270620.0, 270792.0, 271687.0, 24705.382365441008, 24949.126780562594, 25031.624525631767, 25203.613801241107, 25211.0, 39857.20285594214, 40254.39618405668, 40540.1891962165, 40848.38727419032, 41238.0, 33642.49536256909, 34165.31669366549, 34326.141846453036, 34389.0, 34459.31081378408, 33858.8307058473, 34256.82871585626, 34287.314253714285, 34554.481682774276, 35247.83162946423, 27025.86487067552, 28394.98788839343, 34049.65950340465, 34266.31467370688, 34278.48582271218, 25103.87448062748, 30403.2399190022, 31798.0, 32014.210014487235, 32031.0, 24078.0, 24659.731746322755, 24732.258032259062, 24738.628920566567, 24777.0], "value": 15358.033353349441, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.1888063051827, 362.4635539401687, 372.0401364479643, 372.68135743938933, 380.376183059782, 12244.938775306122, 12694.492220311187, 16146.354145834168, 16173.514794556153, 17097.57256068596, 16128.435504757335, 16432.17839108046, 16464.917675411605, 16574.17684054753, 16765.245563949622, 4785.808567657289, 4800.231962885939, 4938.827141050073, 5180.533751962323, 5180.6373553851245, 4939.456659767423, 5073.84778456645, 5075.822346217883, 5075.9492405076035, 5084.669496482736, 4898.951010489903, 5062.822801201959, 5070.138076527, 5072.137736584771, 5082.0, 5068.619853510983, 5143.382794064718, 5144.897102057937, 5147.613928955343, 5149.665271757323, 4409.9559004410185, 4601.4248218972625, 4608.677392582521, 4610.815567377301, 4613.515580863995, 19790.307339243056, 19931.50171245716, 20056.0, 20340.288089916783, 20347.389578312675, 1859.3823373664864, 1963.6759934610773, 2251.1783199132365, 2339.520398318358, 2439.329184474284, 12373.381330933418, 12861.807072893915, 12969.351532423436, 13066.0, 13355.544648213488, 1667.1997441228277, 1703.633718750462, 1725.2150271626506, 1745.197209283731, 1755.3417468449331, 67509.9999999995, 68204.0, 68226.65886670534, 68378.65810670915, 68996.3100368995, 8110.513369197867, 8725.476471411608, 8778.95610521956, 8824.95587522071, 8935.687250946186, 11631.941840290745, 11676.532938682527, 11680.415979201176, 11685.298882067103, 11707.0, 6513.316101809241, 6739.528233023641, 6780.084688567079, 6883.0, 6945.687444065029, 6551.770688025897, 6664.366885145903, 6879.174499060145, 6931.445484361239, 6947.89578156328, 3722.3671975764187, 3741.8503259869844, 3754.3805272129794, 3805.771653700787, 3829.9617003829603, 1782.5721826761485, 1784.164047298319, 1784.2773676660972, 1853.2209079283768, 1874.4282993687057, 783.5142211828703, 820.1716266570807, 858.8539948208819, 913.8720579118929, 940.210223412337, 16511.669766604602, 16517.83482165187, 17197.828021719874, 17366.0, 17579.384721534683, 806.338802182205, 835.4486039214089, 853.7652145659994, 871.779508687842, 884.7036242858586, 9114.453132812052, 9308.581113849894, 9764.755881103029, 9771.413715177112, 9944.900550994542, 391902.0, 391932.2505011728, 399920.0075992776, 401517.0, 410634.0, 76144.61927690326, 79083.0, 83199.16800831915, 83465.58267208625, 84770.5761471201, 900.2033200617501, 930.8929473110679, 932.9440233586007, 935.8362286599681, 937.9718608441758, 14295.714085718435, 14383.352749126523, 14396.712065758416, 14631.561053168421, 15139.394424223348, 37277.25445491129, 37547.249055019296, 38278.808605956794, 38532.42201366926, 38804.80597597107, 51238.0, 53547.46452535425, 53962.0, 54289.72855135699, 54399.0, 7390.5196162249285, 7651.502652327804, 7699.88450173259, 7720.845583088195, 8024.478408903403, 8704.695335663222, 10887.673369798918, 11068.5572577096, 11909.76180476403, 12035.277883327028, 10023.298369114384, 10055.29612927088, 10281.74295642615, 10334.793304133726, 10720.142388609049, 9655.372400793925, 10152.644657436955, 10287.382757034602, 10489.895101048893, 10618.0, 9907.900920990985, 9994.650187243702, 10402.531886064993, 10500.422476763852, 10514.369137851754, 7359.411247100326, 7404.629768511661, 7536.623168841426, 7551.622418878924, 7623.161452240138, 9063.773405664648, 10032.147267482054, 10177.84733229017, 10278.383297002203, 10757.569697212024], "value": 8055.180634689729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.4466662335265, 1365.7951307303904, 1366.3646404421943, 1428.8356838963516, 1675.3466148202203, 6592.4396426303765, 7414.406847452205, 7681.923180768191, 7684.884726729104, 7963.124056353797, 7781.2996830285265, 7830.9216907830905, 7832.295093441589, 7837.764867053983, 7850.568218747967, 2168.9566208675815, 2187.5515519318583, 2195.19875245535, 2196.1325276515768, 2196.6814811852273, 2154.396768904709, 2174.7281589801273, 2226.7105276314055, 2230.29745630126, 2236.709227800392, 2164.1235299703644, 2180.607490651682, 2184.14818220894, 2187.168875827191, 2208.381653137124, 2126.1920470221294, 2137.7969092936146, 2138.786121387864, 2139.5399989002285, 2140.0, 2083.864548804338, 2132.061892767193, 2134.0396821430263, 2135.8077773000505, 2141.100737690174, 7479.962600186965, 7520.548767073993, 7616.961915190389, 7617.0, 7619.504732192389, 4556.931646025312, 4776.044791041771, 4783.402074740658, 4786.617070634341, 4788.832390866303, 2651.7613414792763, 2792.218178909888, 2832.107886015898, 2866.426714657077, 2874.9712502874913, 856.0326830681353, 865.2558799432483, 865.8398196333699, 1648.2994727240875, 1649.043554738261, 10237.795244095076, 10266.435346055963, 10283.79432411355, 10376.63681771142, 10456.37261764289, 3797.2974999625158, 3884.514435695538, 4003.659688926474, 4026.094128820992, 4227.365895115758, 8377.49735015901, 8396.202360775716, 8396.622152003174, 8398.706045288507, 8401.453905496122, 4558.8632341029825, 4566.703164294377, 4574.199515084847, 4598.586127248564, 4608.377868987711, 3577.141486043331, 3730.403135498307, 4080.0, 4177.916441671149, 4190.182914331676, 3321.534985102088, 3365.3269346130874, 3478.0783092480515, 3481.808500532444, 3502.176988407722, 981.764376549623, 987.8123156600367, 992.3153024413132, 993.1855878179823, 1030.7732298894232, 833.1751565949787, 846.5851732650957, 851.67210623909, 879.6393478673713, 885.6236099657749, 5109.284700141909, 5163.251328557413, 5205.490407781701, 5236.319278493847, 5249.133892907704, 404.14926579549626, 408.48530851127197, 412.5152945289273, 414.34947133001504, 867.4101610904519, 3719.442083687414, 3857.4213867919475, 3873.5932727063814, 3893.2213557288655, 3945.1320709443876, 9278.072192780668, 9598.040195980346, 9667.564959576835, 9678.0, 9696.175825054808, 9631.518424078908, 9647.71056868295, 9647.951760241154, 9651.90348096524, 9665.90334096664, 6960.686769095403, 7230.710771569184, 7256.0, 7431.8142046449275, 7442.06974128234, 5452.400235974119, 5537.916931246115, 5593.356763972032, 5682.176084467812, 5741.799037033684, 8456.365772567206, 8623.094575069528, 8666.869996950178, 8695.565221738761, 8748.562571871254, 8800.075992020746, 8950.194482496347, 8953.865692014755, 9073.863892041492, 9089.045650206634, 5827.94172058274, 6025.849353766191, 6479.449246814073, 6615.073889655549, 6644.235912870082, 6960.303969602999, 7209.0628218331285, 7220.819479513054, 7372.336489715952, 7382.630868456663, 6560.573562718408, 6682.866342673216, 6701.363370479797, 6711.429528490133, 6851.3491218334175, 6291.496680265476, 6320.273168585672, 6330.683465826598, 6352.428281454507, 6368.044793281045, 6194.0, 6294.590851594632, 6310.432061114522, 6312.368763123651, 6314.179156709598, 4609.562091601292, 4743.478217396153, 4804.327394164749, 4823.686460380064, 4829.44461386945, 4474.709143905636, 4523.547645235451, 4569.840055598038, 4702.600278976189, 4737.928931065968], "value": 4040.1860068192477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.61569959053224, 296.0629607292918, 303.23584566891435, 304.415522197381, 307.6554259229663, 4556.4760052593965, 4708.670393072478, 4793.304970779235, 4823.421189457265, 4832.106060378828, 4562.452505699321, 4642.558956899097, 4681.789319480623, 4705.988212534305, 4745.928811067837, 3758.5489741230954, 3759.0, 3775.49030880831, 3792.810359482015, 3793.7154713396467, 3768.8304026318883, 3789.658930696237, 3793.867214647488, 3798.8480460781534, 3809.847606095753, 3635.7273204509634, 3751.1372384351616, 3772.3964165733487, 3773.52830896138, 3793.5068441102617, 3743.7005039596766, 3762.9811850940846, 3763.5483741951143, 3771.679407250387, 3774.9811250943844, 3352.5641666583188, 3352.932941341184, 3355.8154301513405, 3359.1266270769534, 3366.343563005215, 4506.81972721094, 4639.30410438437, 4661.46393164787, 4666.2767271073035, 4702.482726900038, 4265.317549192146, 4282.72162309452, 4283.186194623012, 4290.806913688892, 4295.463067116611, 4985.35190425246, 4988.87527811804, 5001.374828146481, 5010.7494625268955, 5017.147084995559, 3659.963400365989, 3666.2667466506537, 3675.206842799492, 3676.6690997810324, 3682.416560878821, 5019.046381187599, 5215.817446389358, 5217.660852044567, 5219.739013049332, 5245.4754524547625, 3737.9626203738158, 3740.4202348636004, 3744.2698673758355, 3746.269477451871, 3755.2864955658883, 3788.659020688096, 3789.488419063446, 3802.2775672622115, 3809.790461524643, 3831.080540670275, 4075.286824805647, 4253.723507971972, 4308.418363520947, 4316.740995540277, 4324.070324880166, 4992.176290911959, 4999.75001249936, 5007.3240112584335, 5011.473795251446, 5078.542931136216, 1243.8445194350707, 1269.942852571618, 1273.6815796050987, 1298.571471414431, 1318.4792007157118, 895.5343221524901, 903.4985583001366, 921.8156368726281, 925.4169872979979, 927.5825878354767, 4374.212641724456, 4379.912401751947, 4391.956080439219, 4413.278821259712, 4420.778961051935, 5090.41460232078, 5096.61775366849, 5100.2349647553165, 5112.335396398445, 5115.335006449138, 4374.4531933508315, 4384.539623339503, 4389.539098394623, 4391.692581519327, 4410.3825464435, 2323.93028209154, 2378.8590268758257, 2390.6414037894106, 2397.386848335323, 2411.854369174628, 4214.620684138442, 4238.131183107455, 4246.3842742802735, 4262.2754131797665, 4280.72175308604, 4568.109218702388, 4598.678092533491, 4603.9079218415445, 4611.377464042378, 4624.699394539344, 4027.777777777766, 4227.915441691211, 4240.618344349024, 4251.936220956688, 4252.532221455637, 4431.316099882024, 4484.955150448453, 4507.2421755514715, 4512.0, 4522.3442600823355, 4384.903774056486, 4395.582419670126, 4414.889627759332, 4426.826890873986, 4436.268015777489, 4019.4774679291504, 4221.662267018693, 4225.894352641209, 4236.293243412015, 4260.7017508775325, 3344.648811874718, 3347.230137068537, 3373.4602463605706, 3396.303757729709, 3416.760826742104, 4522.909541809079, 4539.776758501501, 4549.567791059844, 4571.337156112411, 4917.164082106122, 4748.976255118702, 4914.778834952364, 4972.552470277692, 5010.273510340907, 5037.017781532566, 4978.178600530872, 4981.651284410056, 4985.177445721415, 4991.775370108281, 4992.176290911959, 4799.28010798383, 4910.656254062182, 4931.890324677062, 4980.153373926369, 4986.900261994812, 4985.3020577118505, 4988.351514303117, 5012.674176178537, 5022.388358053719, 5028.547430731252, 4916.434610019894, 4917.704937703606, 4933.309336692794, 4948.604111671129, 4955.45489996093], "value": 3677.099770327581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.4399328590839, 670.249320760748, 693.9791806245809, 717.1824120502624, 732.2092140488271, 11442.828357574643, 12424.130310878241, 12437.253764774108, 12445.937770311159, 12453.937730311347, 12078.637640870766, 12200.75598488032, 12211.328376939266, 12213.328266945337, 12273.079519036064, 742.595285569366, 764.678834889345, 765.3456294867891, 767.3324207939073, 772.5828052851454, 747.7868807389895, 749.6139488163573, 749.9775006749807, 750.6359415683389, 751.2337415835872, 790.4940837863771, 790.5414859381574, 791.3471386106456, 791.5804623549528, 792.5205250823255, 787.8503084413971, 790.0716657926913, 790.7548659915444, 795.1134485049187, 796.5897562755185, 589.3929252869551, 590.6190507122882, 590.8197999610118, 590.8581940334332, 590.8936391449537, 10885.510152043176, 10900.727481812939, 10908.563657453693, 10915.508802103925, 10918.454077296103, 10201.489925503694, 10581.576736930514, 10679.893201068046, 10750.139988800955, 11223.943880280547, 9272.582733776997, 9352.859707104399, 9466.0, 9572.090651388107, 9654.903450965541, 3043.1479185828002, 3067.4631939410515, 3071.7389021933163, 3105.5652208690576, 3112.59536260287, 56820.0, 57066.42933570694, 57868.71065644687, 58186.41813581852, 58938.11592826068, 7672.1560628330835, 7692.153863075057, 7742.10965738936, 7776.377889768805, 7859.174786647434, 15533.0, 15541.0, 15568.532944011698, 15592.766108508382, 15637.921810390875, 6339.778107766206, 6456.160699109179, 6633.336666333328, 6654.500912431587, 6844.041834143224, 3471.062813040465, 3602.6757591816863, 3648.7993160375904, 3653.5250417446096, 3685.539307586552, 2884.293348129722, 2976.255936015996, 2996.0076549095043, 2998.7301142897245, 3005.2637103909683, 480.51708033426183, 480.89420327527887, 483.38368580060705, 485.3738677106564, 489.9142650036229, 479.2499737910229, 496.84846121932435, 553.3581045986637, 565.2425749495613, 572.9457797652257, 7304.5252058616015, 7719.575423351657, 7743.457957943003, 7801.960990195126, 7807.609619519001, 506.25074889164244, 516.2488579117376, 557.8967890940189, 580.1674596953385, 588.8321828279005, 3523.894283171509, 3774.7735135891385, 3832.3868181091448, 3984.083660758042, 4050.635442810102, 90375.0, 96902.0, 98577.0, 99580.50209748905, 99932.0, 85965.0, 86919.0, 86941.5652921744, 87306.56346718226, 87841.0, 72732.0, 73772.0, 74006.62996684982, 74160.62919685367, 77843.0, 7061.682224299816, 7194.388476979515, 7232.493725439169, 7290.781276561712, 7334.229905860021, 43293.134137317706, 44354.0, 44571.777141114086, 44701.776491117336, 45030.324545132506, 38428.80785596054, 39485.605143948196, 46757.532424675315, 53201.7339913298, 56036.0, 10628.25602207838, 10810.67567972962, 10895.400752958663, 11426.314421134759, 11655.475503602189, 11843.881561184622, 12053.337066461429, 12436.502539898303, 12803.871961280269, 13432.731345372842, 11082.294958166844, 11618.128640351839, 12211.816822747844, 12364.81274107254, 12472.87527124717, 11268.267562608404, 11512.079033677119, 11893.46479408446, 11926.403679815801, 12059.939700301442, 11004.834927476255, 11679.824802627798, 12126.27242365461, 12225.938870305592, 12240.632781016584, 9158.542072896462, 9789.167920726533, 9811.901880981384, 9931.155851752394, 9986.950065249628, 9053.59258833341, 9457.952710236405, 9933.3543319684, 10002.899971000197, 10036.799264014533], "value": 6189.963179628116, "unit": "score"}], "name": "dromaeo_css", "value": 6125.209375929751, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 116.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 125.0, 172.0, 130.0, 131.0, 129.0, 142.0, 165.0, 132.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 161.0, 162.0, 162.0, 162.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 107.0, 76.0, 76.0, 76.0, 76.0, 117.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 83.0, 83.0, 84.0, 116.0, 83.0, 83.0, 111.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 84.0, 90.0, 83.0, 98.0, 89.0, 83.0, 83.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 143.0, 139.0, 138.0, 146.0, 142.0, 137.0, 180.0, 143.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 186.0, 177.0, 177.0, 178.0, 177.0, 179.0, 177.0, 176.0, 178.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 70.0, 69.0, 70.0, 70.0, 71.0, 75.0, 69.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1562.6999999999998, "alertThreshold": 2.0}]} 12:23:55 INFO - Return code: 0 12:23:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:23:55 INFO - # TBPL SUCCESS # 12:23:55 INFO - Running post-action listener: _resource_record_post_action 12:23:55 INFO - [mozharness: 2016-10-12 19:23:55.519606Z] Finished run-tests step (success) 12:23:55 INFO - Running post-run listener: _resource_record_post_run 12:23:55 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396259328; Read time: 16; Write time: 309064 12:23:55 INFO - TinderboxPrint: CPU usage
13.1% 12:23:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:23:55 INFO - TinderboxPrint: I/O write bytes / time
396,259,328 / 309,064 12:23:55 INFO - TinderboxPrint: CPU idle
8,354.7 (86.9%) 12:23:55 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 12:23:55 INFO - TinderboxPrint: Swap in / out
0 / 0 12:23:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104120320; Read time: 0; Write time: 88280 12:23:55 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292139008; Read time: 16; Write time: 220784 12:23:56 INFO - Running post-run listener: _upload_blobber_files 12:23:56 INFO - Blob upload gear active. 12:23:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:23:56 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:23:56 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:23:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:57 INFO - (blobuploader) - INFO - Done attempting. 12:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:24:00 INFO - (blobuploader) - INFO - Done attempting. 12:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:24:01 INFO - (blobuploader) - INFO - Done attempting. 12:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:24:01 INFO - Return code: 0 12:24:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ca35f0375aca4805b7ebe0448672f376e9b5493b171f00165aa9eaf2d2748acf4db703f9bed9ccf01d58e8431b0bdd8846f71fa43d69719a5a33ec8fd27f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcd1e93390ba89ab36226046320c1112244b749976d69840684ccd51a00aeed591229055a05d223fea3a72cfd404e71bff16851eb13ade2d4fc3d44246cf55b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc52bd267287e9ef79de4b7f2439f1112714baebfcf16942fbed3b9835ecccda0187b8b3b66ac8b610f36f8507a33f53516bd70a2a608a9d05c0d618f87017f0"} 12:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:24:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:24:01 INFO - Contents: 12:24:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ca35f0375aca4805b7ebe0448672f376e9b5493b171f00165aa9eaf2d2748acf4db703f9bed9ccf01d58e8431b0bdd8846f71fa43d69719a5a33ec8fd27f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcd1e93390ba89ab36226046320c1112244b749976d69840684ccd51a00aeed591229055a05d223fea3a72cfd404e71bff16851eb13ade2d4fc3d44246cf55b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc52bd267287e9ef79de4b7f2439f1112714baebfcf16942fbed3b9835ecccda0187b8b3b66ac8b610f36f8507a33f53516bd70a2a608a9d05c0d618f87017f0"} 12:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:24:01 INFO - Copying logs to upload dir... 12:24:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.829569 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 12:24:00.843492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 12:24:00.847157) ========= 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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ca35f0375aca4805b7ebe0448672f376e9b5493b171f00165aa9eaf2d2748acf4db703f9bed9ccf01d58e8431b0bdd8846f71fa43d69719a5a33ec8fd27f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcd1e93390ba89ab36226046320c1112244b749976d69840684ccd51a00aeed591229055a05d223fea3a72cfd404e71bff16851eb13ade2d4fc3d44246cf55b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc52bd267287e9ef79de4b7f2439f1112714baebfcf16942fbed3b9835ecccda0187b8b3b66ac8b610f36f8507a33f53516bd70a2a608a9d05c0d618f87017f0"} build_url:https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/QtEjFgwyTKulr-lCGQ2_2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ca35f0375aca4805b7ebe0448672f376e9b5493b171f00165aa9eaf2d2748acf4db703f9bed9ccf01d58e8431b0bdd8846f71fa43d69719a5a33ec8fd27f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bcd1e93390ba89ab36226046320c1112244b749976d69840684ccd51a00aeed591229055a05d223fea3a72cfd404e71bff16851eb13ade2d4fc3d44246cf55b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dc52bd267287e9ef79de4b7f2439f1112714baebfcf16942fbed3b9835ecccda0187b8b3b66ac8b610f36f8507a33f53516bd70a2a608a9d05c0d618f87017f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 12:24:00.873078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:24:00.873425) ========= 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=232498196343f89f466a4a9a000001c8-1476298990.475711-1320675313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:24:00.956968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 12:24:00.957378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 12:24:00.957805) ========= ========= Total master_lag: 0.16 =========