builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1480159849.11 results: success (0) buildid: 20161126004005 builduid: 2dd85c114d6048d08be196af4bcca96f revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.107162) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.107606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.108080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.140246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.140509) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 03:30:49-- 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% 102M=0s 2016-11-26 03:30:49 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.286079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.286384) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018300 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.354448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 03:30:49.354814) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 03:30:50,138 truncating revision to first 12 chars 2016-11-26 03:30:50,138 Setting DEBUG logging. 2016-11-26 03:30:50,138 attempt 1/10 2016-11-26 03:30:50,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d87b17a47f60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 03:30:51,223 unpacking tar archive at: mozilla-aurora-d87b17a47f60/testing/mozharness/ program finished with exit code 0 elapsedTime=1.506198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 03:30:50.876404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.876736) ========= script_repo_revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.877167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.877442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.890933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-26 03:30:50.891376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:51 INFO - MultiFileLogger online at 20161126 03:30:51 in /builds/slave/test 03:30:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:51 INFO - {'append_to_log': False, 03:30:51 INFO - 'base_work_dir': '/builds/slave/test', 03:30:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:51 INFO - 'branch': 'Mozilla-Aurora', 03:30:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:51 INFO - 'config_files': ('talos/linux_config.py',), 03:30:51 INFO - 'default_actions': ('clobber', 03:30:51 INFO - 'read-buildbot-config', 03:30:51 INFO - 'download-and-extract', 03:30:51 INFO - 'populate-webroot', 03:30:51 INFO - 'create-virtualenv', 03:30:51 INFO - 'install', 03:30:51 INFO - 'run-tests'), 03:30:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:51 INFO - 'download_minidump_stackwalk': True, 03:30:51 INFO - 'download_symbols': 'ondemand', 03:30:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:51 INFO - 'installer_path': 'installer.exe', 03:30:51 INFO - 'log_level': 'info', 03:30:51 INFO - 'log_name': 'talos', 03:30:51 INFO - 'log_to_console': True, 03:30:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:51 INFO - 'opt_config_files': (), 03:30:51 INFO - 'pip_index': False, 03:30:51 INFO - 'sps_profile': False, 03:30:51 INFO - 'sps_profile_interval': 0, 03:30:51 INFO - 'suite': 'dromaeojs', 03:30:51 INFO - 'system_bits': '32', 03:30:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:51 INFO - 'title': 'talos-linux64-ix-042', 03:30:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:51 INFO - 'use_talos_json': True, 03:30:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:51 INFO - 'work_dir': 'build'} 03:30:51 INFO - [mozharness: 2016-11-26 11:30:51.764810Z] Running clobber step. 03:30:51 INFO - Running pre-action listener: _resource_record_pre_action 03:30:51 INFO - Running main action method: clobber 03:30:51 INFO - rmtree: /builds/slave/test/build 03:30:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:52 INFO - Running post-action listener: _resource_record_post_action 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.226314Z] Finished clobber step (success) 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.226415Z] Running read-buildbot-config step. 03:30:52 INFO - Running pre-action listener: _resource_record_pre_action 03:30:52 INFO - Running main action method: read_buildbot_config 03:30:52 INFO - Using buildbot properties: 03:30:52 INFO - { 03:30:52 INFO - "project": "", 03:30:52 INFO - "product": "firefox", 03:30:52 INFO - "script_repo_revision": "production", 03:30:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:30:52 INFO - "repository": "", 03:30:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:30:52 INFO - "buildid": "20161126004005", 03:30:52 INFO - "stage_platform": "linux64-pgo", 03:30:52 INFO - "basedir": "/builds/slave/test", 03:30:52 INFO - "nightly_build": "True", 03:30:52 INFO - "buildnumber": 619, 03:30:52 INFO - "slavename": "talos-linux64-ix-042", 03:30:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:52 INFO - "platform": "ubuntu64_hw", 03:30:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:52 INFO - "branch": "mozilla-aurora", 03:30:52 INFO - "repo_path": "releases/mozilla-aurora", 03:30:52 INFO - "revision": "d87b17a47f600b30cad7e7a48dfaa42d3faa7678", 03:30:52 INFO - "pgo_build": "True", 03:30:52 INFO - "builduid": "2dd85c114d6048d08be196af4bcca96f", 03:30:52 INFO - "slavebuilddir": "test" 03:30:52 INFO - } 03:30:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:30:52 INFO - Running post-action listener: _resource_record_post_action 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.228952Z] Finished read-buildbot-config step (success) 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.229041Z] Running download-and-extract step. 03:30:52 INFO - Running pre-action listener: _resource_record_pre_action 03:30:52 INFO - Running main action method: download_and_extract 03:30:52 INFO - mkdir: /builds/slave/test/build/tests 03:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:52 INFO - trying https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:52 INFO - Downloaded 1361 bytes. 03:30:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:52 INFO - Using the following test package requirements: 03:30:52 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:52 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:52 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:52 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'jsshell-linux-x86_64.zip'], 03:30:52 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:52 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:52 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:52 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:52 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:52 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:52 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:52 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:53 INFO - Http code: 200 03:30:53 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 03:30:53 INFO - x-amz-cf-id: aItBZQYoLCMm8-3AFDFUf5KocLJjtLwoI6FXQnXtD1ram28xRRE1ng== 03:30:53 INFO - x-amz-version-id: jTS9PUHa9e1xTTkyceU6MJz5saDMS5H7 03:30:53 INFO - Expected file size: 21951483 03:30:53 INFO - Obtained file size: 21951483 03:30:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:57 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:58 INFO - Http code: 200 03:30:58 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:30:58 INFO - x-amz-cf-id: 9jisxpgI2fjOda_TWO9rCo7tAfTCibxDWVufHdLeJ4M_3uG2s_2NJQ== 03:30:58 INFO - x-amz-version-id: jTS9PUHa9e1xTTkyceU6MJz5saDMS5H7 03:30:58 INFO - Expected file size: 21951483 03:30:58 INFO - Obtained file size: 21951483 03:31:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:02 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:31:03 INFO - Http code: 200 03:31:03 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 03:31:03 INFO - x-amz-cf-id: EXXt9ODpGn0bK1vyIvwT9FEXFYuSsThXW82AqGdUXCncDzFidox--Q== 03:31:03 INFO - x-amz-version-id: Aj4ImqDA8y0lTly.spXZjjCGn0KGUY2o 03:31:03 INFO - Expected file size: 14409038 03:31:03 INFO - Obtained file size: 14409038 03:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:03 INFO - trying https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:03 INFO - Downloading https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:05 INFO - Downloaded 63960267 bytes. 03:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:05 INFO - mkdir: /builds/slave/test/properties 03:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:05 INFO - Contents: 03:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:05 INFO - Running post-action listener: _resource_record_post_action 03:31:05 INFO - Running post-action listener: set_extra_try_arguments 03:31:05 INFO - [mozharness: 2016-11-26 11:31:05.681345Z] Finished download-and-extract step (success) 03:31:05 INFO - [mozharness: 2016-11-26 11:31:05.681571Z] Running populate-webroot step. 03:31:05 INFO - Running pre-action listener: _resource_record_pre_action 03:31:05 INFO - Running main action method: populate_webroot 03:31:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:05 INFO - '--tppagecycles', 03:31:05 INFO - '7'], 03:31:05 INFO - 'tests': ['tsvgm']}}, 03:31:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['damp', 'tps']}, 03:31:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'tests': ['damp', 'tps']}, 03:31:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['dromaeo_dom']}, 03:31:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['basic_compositor_video']}, 03:31:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['a11yr', 03:31:05 INFO - 'ts_paint', 03:31:05 INFO - 'tpaint', 03:31:05 INFO - 'sessionrestore', 03:31:05 INFO - 'sessionrestore_no_auto_restore', 03:31:05 INFO - 'tabpaint']}, 03:31:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['tsvgx', 03:31:05 INFO - 'tsvgr_opacity', 03:31:05 INFO - 'tart', 03:31:05 INFO - 'tscrollx', 03:31:05 INFO - 'cart']}, 03:31:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:05 INFO - 'tsvgr_opacity', 03:31:05 INFO - 'tart', 03:31:05 INFO - 'tscrollx', 03:31:05 INFO - 'cart']}, 03:31:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'talos_options': ['--disable-e10s'], 03:31:05 INFO - 'tests': ['tp5o']}, 03:31:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'tests': ['tp5o']}, 03:31:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'talos_options': ['--disable-e10s', 03:31:05 INFO - '--xperf_path', 03:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:05 INFO - 'tests': ['tp5n']}, 03:31:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:05 INFO - 'talos_options': ['--xperf_path', 03:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:05 INFO - 'tests': ['tp5n']}}, 03:31:05 INFO - 'talos.zip': {'path': '', 03:31:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:05 INFO - Running post-action listener: _resource_record_post_action 03:31:05 INFO - [mozharness: 2016-11-26 11:31:05.701797Z] Finished populate-webroot step (success) 03:31:05 INFO - [mozharness: 2016-11-26 11:31:05.701885Z] Running create-virtualenv step. 03:31:05 INFO - Running pre-action listener: _resource_record_pre_action 03:31:05 INFO - Running main action method: create_virtualenv 03:31:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:05 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 03:31:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:05 INFO - Using real prefix '/usr' 03:31:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:08 INFO - Installing pip.................done. 03:31:08 INFO - Return code: 0 03:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:31:08 INFO - Reading from file tmpfile_stdout 03:31:08 INFO - Output received: 03:31:08 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) 03:31:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:08 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')]} 03:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:08 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')]} 03:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:08 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:08 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 03:31:08 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 03:31:08 INFO - Using env: {'DISPLAY': ':0', 03:31:08 INFO - 'HOME': '/home/cltbld', 03:31:08 INFO - 'LANG': 'en_US.UTF-8', 03:31:08 INFO - 'LANGUAGE': 'en_US:en', 03:31:08 INFO - 'LOGNAME': 'cltbld', 03:31:08 INFO - 'MAIL': '/var/mail/cltbld', 03:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:08 INFO - 'MOZ_NO_REMOTE': '1', 03:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:08 INFO - 'NO_EM_RESTART': '1', 03:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:08 INFO - 'PWD': '/builds/slave/test', 03:31:08 INFO - 'SHELL': '/bin/bash', 03:31:08 INFO - 'SHLVL': '1', 03:31:08 INFO - 'TERM': 'linux', 03:31:08 INFO - 'TMOUT': '86400', 03:31:08 INFO - 'USER': 'cltbld', 03:31:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:08 INFO - '_': '/tools/buildbot/bin/python'} 03:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:08 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 03:31:08 INFO - Cleaning up... 03:31:08 INFO - Return code: 0 03:31:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:08 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')]} 03:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:08 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')]} 03:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:08 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:08 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 03:31:08 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 03:31:08 INFO - Using env: {'DISPLAY': ':0', 03:31:08 INFO - 'HOME': '/home/cltbld', 03:31:08 INFO - 'LANG': 'en_US.UTF-8', 03:31:08 INFO - 'LANGUAGE': 'en_US:en', 03:31:08 INFO - 'LOGNAME': 'cltbld', 03:31:08 INFO - 'MAIL': '/var/mail/cltbld', 03:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:08 INFO - 'MOZ_NO_REMOTE': '1', 03:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:08 INFO - 'NO_EM_RESTART': '1', 03:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:08 INFO - 'PWD': '/builds/slave/test', 03:31:08 INFO - 'SHELL': '/bin/bash', 03:31:08 INFO - 'SHLVL': '1', 03:31:08 INFO - 'TERM': 'linux', 03:31:08 INFO - 'TMOUT': '86400', 03:31:08 INFO - 'USER': 'cltbld', 03:31:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:08 INFO - '_': '/tools/buildbot/bin/python'} 03:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:08 INFO - Downloading/unpacking psutil>=3.1.1 03:31:08 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 03:31:08 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 03:31:08 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 03:31:08 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 03:31:08 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 03:31:08 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 03:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:10 INFO - Installing collected packages: psutil 03:31:10 INFO - Running setup.py install for psutil 03:31:11 INFO - building 'psutil._psutil_linux' extension 03:31:11 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 03:31:11 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 03:31:11 INFO - building 'psutil._psutil_posix' extension 03:31:11 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 03:31:11 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 03:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:11 INFO - Successfully installed psutil 03:31:11 INFO - Cleaning up... 03:31:11 INFO - Return code: 0 03:31:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:11 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')]} 03:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:11 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')]} 03:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:11 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:11 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 03:31:11 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 03:31:11 INFO - Using env: {'DISPLAY': ':0', 03:31:11 INFO - 'HOME': '/home/cltbld', 03:31:11 INFO - 'LANG': 'en_US.UTF-8', 03:31:11 INFO - 'LANGUAGE': 'en_US:en', 03:31:11 INFO - 'LOGNAME': 'cltbld', 03:31:11 INFO - 'MAIL': '/var/mail/cltbld', 03:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:11 INFO - 'MOZ_NO_REMOTE': '1', 03:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:11 INFO - 'NO_EM_RESTART': '1', 03:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:11 INFO - 'PWD': '/builds/slave/test', 03:31:11 INFO - 'SHELL': '/bin/bash', 03:31:11 INFO - 'SHLVL': '1', 03:31:11 INFO - 'TERM': 'linux', 03:31:11 INFO - 'TMOUT': '86400', 03:31:11 INFO - 'USER': 'cltbld', 03:31:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:11 INFO - '_': '/tools/buildbot/bin/python'} 03:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:11 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 03:31:11 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 03:31:11 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 03:31:11 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 03:31:11 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 03:31:11 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 03:31:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:13 INFO - Installing collected packages: mozsystemmonitor 03:31:13 INFO - Running setup.py install for mozsystemmonitor 03:31:13 INFO - Successfully installed mozsystemmonitor 03:31:13 INFO - Cleaning up... 03:31:13 INFO - Return code: 0 03:31:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:13 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')]} 03:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:13 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')]} 03:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:13 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:13 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 03:31:13 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 03:31:13 INFO - Using env: {'DISPLAY': ':0', 03:31:13 INFO - 'HOME': '/home/cltbld', 03:31:13 INFO - 'LANG': 'en_US.UTF-8', 03:31:13 INFO - 'LANGUAGE': 'en_US:en', 03:31:13 INFO - 'LOGNAME': 'cltbld', 03:31:13 INFO - 'MAIL': '/var/mail/cltbld', 03:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:13 INFO - 'MOZ_NO_REMOTE': '1', 03:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:13 INFO - 'NO_EM_RESTART': '1', 03:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:13 INFO - 'PWD': '/builds/slave/test', 03:31:13 INFO - 'SHELL': '/bin/bash', 03:31:13 INFO - 'SHLVL': '1', 03:31:13 INFO - 'TERM': 'linux', 03:31:13 INFO - 'TMOUT': '86400', 03:31:13 INFO - 'USER': 'cltbld', 03:31:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:13 INFO - '_': '/tools/buildbot/bin/python'} 03:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:14 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 03:31:14 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 03:31:14 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 03:31:14 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 03:31:14 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 03:31:14 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 03:31:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:16 INFO - warning: no files found matching '*.txt' 03:31:16 INFO - no previously-included directories found matching 'build' 03:31:16 INFO - no previously-included directories found matching 'dist' 03:31:16 INFO - no previously-included directories found matching '.git*' 03:31:16 INFO - Installing collected packages: jsonschema, functools32 03:31:16 INFO - Running setup.py install for functools32 03:31:16 INFO - warning: no files found matching '*.txt' 03:31:16 INFO - no previously-included directories found matching 'build' 03:31:16 INFO - no previously-included directories found matching 'dist' 03:31:16 INFO - no previously-included directories found matching '.git*' 03:31:16 INFO - Successfully installed jsonschema functools32 03:31:16 INFO - Cleaning up... 03:31:16 INFO - Return code: 0 03:31:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:16 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:16 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 03:31:16 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 03:31:16 INFO - Using env: {'DISPLAY': ':0', 03:31:16 INFO - 'HOME': '/home/cltbld', 03:31:16 INFO - 'LANG': 'en_US.UTF-8', 03:31:16 INFO - 'LANGUAGE': 'en_US:en', 03:31:16 INFO - 'LOGNAME': 'cltbld', 03:31:16 INFO - 'MAIL': '/var/mail/cltbld', 03:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:16 INFO - 'MOZ_NO_REMOTE': '1', 03:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:16 INFO - 'NO_EM_RESTART': '1', 03:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:16 INFO - 'PWD': '/builds/slave/test', 03:31:16 INFO - 'SHELL': '/bin/bash', 03:31:16 INFO - 'SHLVL': '1', 03:31:16 INFO - 'TERM': 'linux', 03:31:16 INFO - 'TMOUT': '86400', 03:31:16 INFO - 'USER': 'cltbld', 03:31:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:16 INFO - '_': '/tools/buildbot/bin/python'} 03:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:16 INFO - Cleaning up... 03:31:16 INFO - Return code: 0 03:31:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:16 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:16 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 03:31:16 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 03:31:16 INFO - Using env: {'DISPLAY': ':0', 03:31:16 INFO - 'HOME': '/home/cltbld', 03:31:16 INFO - 'LANG': 'en_US.UTF-8', 03:31:16 INFO - 'LANGUAGE': 'en_US:en', 03:31:16 INFO - 'LOGNAME': 'cltbld', 03:31:16 INFO - 'MAIL': '/var/mail/cltbld', 03:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:16 INFO - 'MOZ_NO_REMOTE': '1', 03:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:16 INFO - 'NO_EM_RESTART': '1', 03:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:16 INFO - 'PWD': '/builds/slave/test', 03:31:16 INFO - 'SHELL': '/bin/bash', 03:31:16 INFO - 'SHLVL': '1', 03:31:16 INFO - 'TERM': 'linux', 03:31:16 INFO - 'TMOUT': '86400', 03:31:16 INFO - 'USER': 'cltbld', 03:31:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:16 INFO - '_': '/tools/buildbot/bin/python'} 03:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:18 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 03:31:18 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 03:31:18 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 03:31:18 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 03:31:18 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 03:31:18 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 03:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:19 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 03:31:19 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 03:31:19 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 03:31:19 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 03:31:19 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 03:31:19 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 03:31:19 INFO - Downloading docopt-0.6.1.tar.gz 03:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:19 INFO - Running setup.py install for blobuploader 03:31:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:19 INFO - Running setup.py install for requests 03:31:20 INFO - Running setup.py install for docopt 03:31:20 INFO - Successfully installed blobuploader requests docopt 03:31:20 INFO - Cleaning up... 03:31:20 INFO - Return code: 0 03:31:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:20 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:20 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 03:31:20 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 03:31:20 INFO - Using env: {'DISPLAY': ':0', 03:31:20 INFO - 'HOME': '/home/cltbld', 03:31:20 INFO - 'LANG': 'en_US.UTF-8', 03:31:20 INFO - 'LANGUAGE': 'en_US:en', 03:31:20 INFO - 'LOGNAME': 'cltbld', 03:31:20 INFO - 'MAIL': '/var/mail/cltbld', 03:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:20 INFO - 'MOZ_NO_REMOTE': '1', 03:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:20 INFO - 'NO_EM_RESTART': '1', 03:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:20 INFO - 'PWD': '/builds/slave/test', 03:31:20 INFO - 'SHELL': '/bin/bash', 03:31:20 INFO - 'SHLVL': '1', 03:31:20 INFO - 'TERM': 'linux', 03:31:20 INFO - 'TMOUT': '86400', 03:31:20 INFO - 'USER': 'cltbld', 03:31:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:20 INFO - '_': '/tools/buildbot/bin/python'} 03:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:20 INFO - Running setup.py (path:/tmp/pip-OFFLwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:20 INFO - Running setup.py (path:/tmp/pip-LJAf6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:20 INFO - Running setup.py (path:/tmp/pip-AhQ2ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:20 INFO - Running setup.py (path:/tmp/pip-Axyq69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:20 INFO - Running setup.py (path:/tmp/pip-ydFCt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:20 INFO - Running setup.py (path:/tmp/pip-Y7WIAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:20 INFO - Running setup.py (path:/tmp/pip-iHqohG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:21 INFO - Running setup.py (path:/tmp/pip-GsEfNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:21 INFO - Running setup.py (path:/tmp/pip-M3u1gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:21 INFO - Running setup.py (path:/tmp/pip-2lAJfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:21 INFO - Running setup.py (path:/tmp/pip-6O0t6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:21 INFO - Running setup.py (path:/tmp/pip-HJ2ETk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:21 INFO - Running setup.py (path:/tmp/pip-meg1Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:21 INFO - Running setup.py (path:/tmp/pip-yeMjg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:21 INFO - Running setup.py (path:/tmp/pip-4MmmwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:21 INFO - Running setup.py (path:/tmp/pip-7pFnlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:21 INFO - Running setup.py (path:/tmp/pip-atltNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:21 INFO - Running setup.py install for manifestparser 03:31:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:21 INFO - Running setup.py install for mozcrash 03:31:21 INFO - Running setup.py install for mozdebug 03:31:22 INFO - Running setup.py install for mozdevice 03:31:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozfile 03:31:22 INFO - Running setup.py install for mozhttpd 03:31:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozinfo 03:31:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozInstall 03:31:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozleak 03:31:22 INFO - Running setup.py install for mozlog 03:31:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for moznetwork 03:31:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozprocess 03:31:22 INFO - Running setup.py install for mozprofile 03:31:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozrunner 03:31:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozscreenshot 03:31:23 INFO - Running setup.py install for moztest 03:31:23 INFO - Running setup.py install for mozversion 03:31:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:23 INFO - Cleaning up... 03:31:23 INFO - Return code: 0 03:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:23 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:23 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 03:31:23 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 03:31:23 INFO - Using env: {'DISPLAY': ':0', 03:31:23 INFO - 'HOME': '/home/cltbld', 03:31:23 INFO - 'LANG': 'en_US.UTF-8', 03:31:23 INFO - 'LANGUAGE': 'en_US:en', 03:31:23 INFO - 'LOGNAME': 'cltbld', 03:31:23 INFO - 'MAIL': '/var/mail/cltbld', 03:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:23 INFO - 'MOZ_NO_REMOTE': '1', 03:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:23 INFO - 'NO_EM_RESTART': '1', 03:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:23 INFO - 'PWD': '/builds/slave/test', 03:31:23 INFO - 'SHELL': '/bin/bash', 03:31:23 INFO - 'SHLVL': '1', 03:31:23 INFO - 'TERM': 'linux', 03:31:23 INFO - 'TMOUT': '86400', 03:31:23 INFO - 'USER': 'cltbld', 03:31:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:23 INFO - '_': '/tools/buildbot/bin/python'} 03:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:23 INFO - Running setup.py (path:/tmp/pip-HmTQAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:23 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)) 03:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:23 INFO - Running setup.py (path:/tmp/pip-XgDeDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:23 INFO - Running setup.py (path:/tmp/pip-WOtDBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:23 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)) 03:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:23 INFO - Running setup.py (path:/tmp/pip-NBKWus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:24 INFO - Running setup.py (path:/tmp/pip-YDEWqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:24 INFO - Running setup.py (path:/tmp/pip-YFGtew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:24 INFO - Running setup.py (path:/tmp/pip-6e96zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:24 INFO - Running setup.py (path:/tmp/pip-0Ww23u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:24 INFO - Running setup.py (path:/tmp/pip-hXDJ2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:24 INFO - Running setup.py (path:/tmp/pip-9BaLUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:24 INFO - Running setup.py (path:/tmp/pip-Qo3wwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:24 INFO - Running setup.py (path:/tmp/pip-mIdKoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:24 INFO - Running setup.py (path:/tmp/pip-6Abeyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:24 INFO - Running setup.py (path:/tmp/pip-sXW79t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:24 INFO - Running setup.py (path:/tmp/pip-zo3oG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:24 INFO - Running setup.py (path:/tmp/pip-aISDpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:24 INFO - Running setup.py (path:/tmp/pip-0U1KcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:24 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)) 03:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:25 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)) 03:31:25 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)) 03:31:25 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)) 03:31:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:25 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 03:31:25 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 03:31:25 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 03:31:25 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 03:31:25 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 03:31:25 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 03:31:26 INFO - Downloading blessings-1.6.tar.gz 03:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:27 INFO - Installing collected packages: blessings 03:31:27 INFO - Running setup.py install for blessings 03:31:27 INFO - Successfully installed blessings 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:27 INFO - Reading from file tmpfile_stdout 03:31:27 INFO - Current package versions: 03:31:27 INFO - argparse == 1.2.1 03:31:27 INFO - blessings == 1.6 03:31:27 INFO - blobuploader == 1.2.4 03:31:27 INFO - docopt == 0.6.1 03:31:27 INFO - functools32 == 3.2.3-2 03:31:27 INFO - jsonschema == 2.5.1 03:31:27 INFO - manifestparser == 1.1 03:31:27 INFO - mozInstall == 1.12 03:31:27 INFO - mozcrash == 1.0 03:31:27 INFO - mozdebug == 0.1 03:31:27 INFO - mozdevice == 0.48 03:31:27 INFO - mozfile == 1.2 03:31:27 INFO - mozhttpd == 0.7 03:31:27 INFO - mozinfo == 0.9 03:31:27 INFO - mozleak == 0.1 03:31:27 INFO - mozlog == 3.4 03:31:27 INFO - moznetwork == 0.27 03:31:27 INFO - mozprocess == 0.23 03:31:27 INFO - mozprofile == 0.28 03:31:27 INFO - mozrunner == 6.13 03:31:27 INFO - mozscreenshot == 0.1 03:31:27 INFO - mozsystemmonitor == 0.3 03:31:27 INFO - moztest == 0.7 03:31:27 INFO - mozversion == 1.4 03:31:27 INFO - psutil == 3.1.1 03:31:27 INFO - requests == 1.2.3 03:31:27 INFO - wsgiref == 0.1.2 03:31:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:27 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 03:31:27 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 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 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)) 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 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 0x7f74b5d59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', '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 03:31:27 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 03:31:27 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 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Running post-action listener: _resource_record_post_action 03:31:27 INFO - Running post-action listener: _start_resource_monitoring 03:31:27 INFO - Starting resource monitoring. 03:31:27 INFO - [mozharness: 2016-11-26 11:31:27.920770Z] Finished create-virtualenv step (success) 03:31:27 INFO - [mozharness: 2016-11-26 11:31:27.921273Z] Running install step. 03:31:27 INFO - Running pre-action listener: _resource_record_pre_action 03:31:27 INFO - Running main action method: install 03:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:28 INFO - Reading from file tmpfile_stdout 03:31:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:28 INFO - Reading from file tmpfile_stdout 03:31:28 INFO - Output received: 03:31:28 INFO - Usage: mozinstall [options] installer 03:31:28 INFO - Options: 03:31:28 INFO - -h, --help show this help message and exit 03:31:28 INFO - -d DEST, --destination=DEST 03:31:28 INFO - Directory to install application into. [default: 03:31:28 INFO - "/builds/slave/test"] 03:31:28 INFO - --app=APP Application being installed. [default: firefox] 03:31:28 INFO - mkdir: /builds/slave/test/build/application 03:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:31:44 INFO - Reading from file tmpfile_stdout 03:31:44 INFO - Output received: 03:31:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:44 INFO - Running post-action listener: _resource_record_post_action 03:31:44 INFO - [mozharness: 2016-11-26 11:31:44.141031Z] Finished install step (success) 03:31:44 INFO - [mozharness: 2016-11-26 11:31:44.141274Z] Running run-tests step. 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: run_tests 03:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:44 INFO - Python 2.7.3 03:31:44 INFO - Return code: 0 03:31:44 INFO - grabbing minidump binary from tooltool 03:31:44 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')]} 03:31:44 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 0x20c7f60>, '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 0x20c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:44 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 03:31:44 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 03:31:44 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 03:31:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:44 INFO - Return code: 0 03:31:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 03:31:44 INFO - Using env: {'DISPLAY': ':0', 03:31:44 INFO - 'HOME': '/home/cltbld', 03:31:44 INFO - 'LANG': 'en_US.UTF-8', 03:31:44 INFO - 'LANGUAGE': 'en_US:en', 03:31:44 INFO - 'LOGNAME': 'cltbld', 03:31:44 INFO - 'MAIL': '/var/mail/cltbld', 03:31:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:44 INFO - 'MOZ_NO_REMOTE': '1', 03:31:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:44 INFO - 'NO_EM_RESTART': '1', 03:31:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:44 INFO - 'PWD': '/builds/slave/test', 03:31:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:44 INFO - 'SHELL': '/bin/bash', 03:31:44 INFO - 'SHLVL': '1', 03:31:44 INFO - 'TERM': 'linux', 03:31:44 INFO - 'TMOUT': '86400', 03:31:44 INFO - 'USER': 'cltbld', 03:31:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827', 03:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:44 INFO - '_': '/tools/buildbot/bin/python'} 03:31:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:31:44 INFO - mozversion application_buildid: 20161126004005 03:31:44 INFO - mozversion application_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 03:31:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:44 INFO - mozversion application_name: Firefox 03:31:44 INFO - mozversion application_remotingname: firefox-dev 03:31:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:44 INFO - mozversion application_vendor: Mozilla 03:31:44 INFO - mozversion application_version: 52.0a2 03:31:44 INFO - mozversion platform_buildid: 20161126004005 03:31:44 INFO - mozversion platform_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 03:31:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:44 INFO - mozversion platform_version: 52.0a2 03:31:44 INFO - using testdate: 1480159904 03:31:44 INFO - actual date: 1480159904 03:31:44 INFO - starting webserver on 'localhost:33542' 03:31:44 INFO - SUITE-START | Running 2 tests 03:31:44 INFO - TEST-START | dromaeo_css 03:31:44 INFO - operating with platform_type : linux_ 03:31:44 INFO - Initialising browser for dromaeo_css test... 03:31:44 INFO - TEST-INFO | started process 20107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mPMeq/profile http://localhost:33542/getInfo.html) 03:31:48 INFO - PROCESS | 20107 | __metrics Screen width/height:1600/1200 03:31:48 INFO - PROCESS | 20107 | colorDepth:24 03:31:48 INFO - PROCESS | 20107 | Browser inner width/height: 1024/697 03:31:48 INFO - PROCESS | 20107 | __metrics 03:31:48 INFO - PROCESS | 20107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:31:48 INFO - PROCESS | 20107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:49 INFO - PROCESS | 20107 | console.error: PushService: 03:31:49 INFO - PROCESS | 20107 | stateChangeProcessEnqueue: Error transitioning state 03:31:49 INFO - PROCESS | 20107 | UnknownError 03:31:50 INFO - TEST-INFO | 20107: exit 0 03:31:50 INFO - Browser initialized. 03:31:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:50 INFO - TEST-INFO | started process 20200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mPMeq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:01 INFO - PROCESS | 20200 | RSS: Main: 144273408 03:32:01 INFO - PROCESS | 20200 | 03:32:53 INFO - PROCESS | 20200 | 1480159973733 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] 03:35:04 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33542/tests/dromaeo/cssquery-ext.html) 03:35:05 INFO - PROCESS | 20200 | RSS: Main: 246181888 03:35:05 INFO - PROCESS | 20200 | 03:38:07 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-ext.html (next: http://localhost:33542/tests/dromaeo/cssquery-jquery.html) 03:38:08 INFO - PROCESS | 20200 | RSS: Main: 232546304 03:38:08 INFO - PROCESS | 20200 | 03:41:10 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33542/tests/dromaeo/cssquery-mootools.html) 03:41:10 INFO - PROCESS | 20200 | RSS: Main: 174161920 03:41:10 INFO - PROCESS | 20200 | 03:44:12 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33542/tests/dromaeo/cssquery-prototype.html) 03:44:13 INFO - PROCESS | 20200 | RSS: Main: 214663168 03:44:13 INFO - PROCESS | 20200 | 03:47:16 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33542/tests/dromaeo/cssquery-yui.html) 03:47:16 INFO - PROCESS | 20200 | RSS: Main: 176349184 03:47:16 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | Cycle 1(1): loaded http://localhost:33542/tests/dromaeo/cssquery-yui.html (next: http://localhost:33542/tests/dromaeo/cssquery-dojo.html) 03:50:19 INFO - PROCESS | 20200 | RSS: Main: 264663040 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | __start_tp_report 03:50:19 INFO - PROCESS | 20200 | _x_x_mozilla_page_load 03:50:19 INFO - PROCESS | 20200 | _x_x_mozilla_page_load_details 03:50:19 INFO - PROCESS | 20200 | |i|pagename|runs| 03:50:19 INFO - PROCESS | 20200 | |0;dojo.html;3220.613526376834;3265.2489927316715;3270.7710460267776;3287.2110693433583;3296.274819539702;5532.419095994918;5626.381098079208;5630.7184640767955;5633.774649014044;5635.5773317001185;5644.774209031634;5709.71451427428;5710.428957104287;5719.742611582478;5749.223854779603;5100.183970564711;5110.66780659256;5146.433892271847;5153.665011774241;5184.792608295664;5056;5059.392872855244;5179.404368497633;5184.896302073957;5191.610629202806;5046.09170349337;5065.341505604285;5080.898382032357;5095.0319439306595;5098.235264710304;5130.127878260705;5143.048536020848;5212.061828870802;5221.373435187802;5253.6322457428;4865.270209468573;5125.384953805567;5146.253793200002;5188.429272779991;5207.713575753332;5420.24116623673;5464.016477034133;5484.890302193974;5493;5572.0527510323345;5891.852703682443;5900.996830538776;5989.9101513477335;5996.070609055603;6008.8497787555225;5908.6454812710945;6047.7278522466595;6062.666553339564;6075.33171351151;6080.939190608082;5561.221428999943;5561.360443549003;5605.663660180402;5618.438156184349;5629.8592535186945;6144.354842741537;6157.199564056644;6170.6914654268;6173.722182501798;6179.412955769195;5695.857603559944;5925.081612350006;5933.732982015819;5936.465718085393;5936.5844390892225;5810.41895810424;5903.35063143054;5953.553483488756;5955.166276721263;6031.698415079229;5976.491998180203;5984.431479009487;5992.31088424828;5994.220751302303;6027.78902738402;5939.049752039653;5988.131720900532;5998.070299103646;6011.248593925759;6012.218411606463;4619.076184763061;4623.468301145344;4626.074785043005;4664.416947881515;4679.3916790816975;4172.3532852407925;4194.140201258735;4203.663706903501;4227.725197862129;4237.5762423758;5829.387914269026;5829.562782791223;5833.941660583425;5837.941620583825;5852.268466441695;5906;5961.374055724174;6011.609245399035;6048.516118710492;6138.938610613836;5818;5824.563157763185;5825.1844741736195;5829.387914268941;5861.062230043172;5261.526462618306;5264.236685680631;5266.8419947401635;5267.183586544092;5270.657407268515;6117.051856962178;6131.437835141539;6149.046897730859;6314.989601663804;6340.778072767431;5953.880922381615;6075.301340345917;6079.088136779518;6102.877942441038;6109.572329936862;6229.345918678474;6293.244810622755;6297.496200303873;6297.874042519215;6302.527310451826;5736.225609542658;5737.627054241461;5936.28764548257;5958.523318134626;5994.280686317496;5995.250593675791;6027.30685971119;6038.607490513103;6111.77406523465;6134.528431832502;5956.463918247206;6006;6012.038073908154;6013.398660133952;6041.305249896318;5721.399253078367;5968.283805943314;5971.28344598651;5980;5990.910136347871;5784.82645520635;5804.738786754522;5851.970740146272;5853.0635098384055;5902.380250073852;5946.613470124428;5952.672603006703;5953.047512397996;5964.671943043174;5973.940260597512;5644.012297847942;5681.801136960186;5709.486146246858;5838.416158384128;5855.94144058554 03:50:19 INFO - PROCESS | 20200 | |1;ext.html;579.4466284698113;627.0437582686403;639.0159154901452;661.3584822721958;673.814700957237;34647;35266.2946741065;37908.81045594775;44902;46065.7696711516;48266.27600585994;48700;48797.26804097941;48815;48841.75579122108;8874.955625221864;9027.909720902806;9028.638854445815;9033.23217526511;9033.909660903373;8497.787555311104;8689;8828.24959878408;8921.598528066253;10505.6323028694;10525.157987360994;10827.133829293638;10834.783304333909;10847.67456976292;10854.565817367296;10634.840477392845;10671.519781609768;10672.893271067267;10701.946490267577;10704.464776761131;10600.151987840954;10612.363258204532;10617.522211500424;10673.03942645158;10707.78584428315;44990.32514512285;45330;45356.092878142255;45386.54613453856;45474;3548.290341931624;3914.256291304643;4203.579642035772;4208.516020657633;4220.376395788577;31789.682103178904;31834.522482162785;32000.359992800248;32285.35429291401;32424.83787581047;4025.6075306881457;4152.1280531088505;4168.4923322047525;4168.7707176105305;4178.289690752579;348310;348748;350105;350220;350569;63765.681171593846;63788.68105659442;64000.35999640037;64000.67999659972;64043.35956640374;40371.192576148314;40768.38847417291;41012;43475.13049738987;69853.65073174704;19807;20059.197632094845;20093.296734614218;20112.296069637494;20129.194832206547;13598.04813663054;13645.38595763193;13653.044286899822;13657.726845463036;13664.31678416095;18941.337053203348;19281.903590482238;20251.898740506203;20821.37535873926;20895.477613059797;7483.588402637907;7516.736914207976;7632.274933881273;7660.463767536219;7666.578338191342;944.1738478831023;1049.506731836036;1101.719061639293;1139.0887290167832;1149.9540018399337;33437.331253374796;33851.4922276166;33886;34087.65912340894;35164.64835351665;1103.0403548912498;1172.2497601535024;1190.988090119105;1200.9095998454268;1283.1338846278725;16805.831941680426;17702;17732.468025959242;17815.0201738903;17977.404574049928;170714.14642926955;172107;172185;172355.1382243081;173375;63061;63751;63923.68038159779;63935.68032159809;64032.35967640357;1417.0930604413184;1432.978505322421;1445.544653434165;1446.3852862533593;1449.5361484324915;32157;33495.49756753699;33647.32705345928;33983.58055324836;34034.489482658275;55611.44388556063;55844.44155558555;55900.16149757838;56010.71994640001;56119;404957;405916;406020;406345;407015;31212.531812022382;31840.36319273648;31853.36293274075;32487.837560812044;33289.83355083209;47948.60256987067;48368.75815620899;48445;48607.5139248603;51764.48235517597;40747.59252407438;42928;43306.35040474458;43374.566254337056;45347.54652453433;43980.78009610059;44572;44803.327950081424;45176.32235516404;45899.311510328036;43654.56345436632;44318;44929.55070449254;45058.32412513749;46455.535444645124;36867.63132368642;38419.6158038416;40223.79888100658;40238.39642405425;40485;29724.108276751733;30001.849990749906;30046.699533005263;30256.394872101995;30480.085597432113 03:50:19 INFO - PROCESS | 20200 | |2;jquery.html;397.9801009949502;408.4955080475612;429.7915510977176;432.8247059940723;440.40325359138365;15498.845011549882;19590.118444669988;20475.795242047592;21023.47441313964;21405.464863378424;19550.31573894914;20187.59624807503;20189;20262.696059559083;20580.794192058074;5556.749946252428;5832.9708351458185;5834.9124763128375;5834.941650583503;5834.970825145869;5637.238972738689;5866.941330586682;5890.646561206341;5978.013627751416;5983.521318294548;5695.629784064023;5947.851303717398;5956.7319470623925;5972.581919265654;5982.401759824026;5865.325487568942;6033.276006879202;6047.274327080779;6052;6059.030555111183;5652.886942261173;5830.883382332329;5835.9708201458725;5840.094785308242;5882.264716910387;15147.015443996104;15365.769513457195;15482.690346193125;21916.561668766695;24035.158769443162;2454.7667971542674;2473.9628905566433;2541.4789968056502;2563.9359016024564;2901.0571564241704;9698.127168554793;10129.13902318304;14828.110313381232;15030.248487575687;15216.923915380352;1821.9726704099448;1894.3464504745841;1916.7795703494137;1937.903104844752;1939.8739081959627;79197;84303;88503.55748221283;89109.55445222733;91902;10650.627228047137;11555.537778488935;11581.826272605918;11602.883971160349;12155.17672349137;15536.92231538835;15906.60233494172;15922.681546369007;15951.760723589156;15974.680506389806;8383.538905360141;8411.873821892677;9167.49578773174;9251.398659087137;9368.62525498986;7704;8618.39671223021;8668.176523230282;8803.471791692518;8927.285817134614;4697.530246975343;4984.401871775338;5096.923546146811;5108.846734597968;5207.29701490294;1875.6998880179106;1962.8233458988475;2077.9376618701463;2128.968065479019;2146.8389870759756;927.8051609162017;981.5975450065439;1003.6085926488676;1008.2589296866797;1033.534909290822;20407.795922040885;20424.367818362232;20517.17931282762;20598;20858.895705521376;998.825205589019;999.0658734083655;1036.1348274190984;1041.9057694035043;1058.0636137018794;10660.786784264426;11566.47950842214;11636.185467017227;11660;11670.241434306912;519722;529194;537122;542412;546695;89365.55317223372;90057.54971225101;90985.09014909899;93326;93562.53218733863;1012.579779391559;1025.8563801067855;1056.3450660590483;1058.2856571813995;1060.0406631998055;17787.644247115244;17805.821941780418;18382.816171838644;18585.16366763472;18638.440846774618;42838;43797.562024379346;43812.34281485844;44718.329225061;45322.54677453183;57392.713036436224;58921.410785891596;61410.38589614047;61649;62271;8064.193580641889;8356.837457767362;8445.113263107285;8736.91263087361;9127.77180570491;10206.760748277195;13836.654083647989;14233.359498822785;14415.063020903608;14822.555323340317;12186.512539498675;12197.695057623276;12629.926456251322;12633;12714.745705086032;6870.587764734132;8253.587320634064;12095.57665481704;12270.141090123605;12564.811527827273;12000;12185.39073046362;12212.267263964191;12306.630801075982;12375;8404.117567655308;8522.573871306535;8554.91445085566;8630.482171069756;8684.652613895374;11105.167112466435;11663;12000.279983201035;12233.69415764613;12570.43433045497 03:50:19 INFO - PROCESS | 20200 | |3;mootools.html;1462.919539425331;1507.4723846653674;1569.45069225771;1708.1117818734267;1713.726781846673;7562.319391254786;7739.922600773991;7869.449138560296;8480.745577632666;8484.830303393928;7828.8042798930055;8086.231807978233;8101.02787665481;8325.666973321075;8336.208060234268;2376.8455050421753;2400.531896280226;2402.0511897800357;2406.7352591214953;2409.0484258717797;2173.174193806359;2240.7759224077545;2397.988010059956;2431.4043059450373;2457.8402403843693;2343.894524746382;2429.4776623026046;2430.4895971845935;2436.2447641231274;2448.424620214257;2344.824138189643;2397.041183526586;2407.265783935899;2410.337157281744;2427.0534491548224;2386.129062892032;2395.8562486250707;2417.16607770319;2418.153646223825;2459.7417271186628;8530.872036919389;8572.957135214347;8591.914080859175;8602.18279263469;8607.956960215159;5271.630985830993;5397.78408863645;5405.324334458192;5408.4050754416985;5411.567074634059;3366.2762506061313;3370.2248482848836;3403.081168084628;3419.829008549563;3473.4616134499192;1108.2131686502594;1115.5036008976008;1153.0948205658517;1155.3775008037244;1179.2511755035528;11287.943560282229;11337.1497137715;11371.431428428628;11392.715182120513;11400.771984560346;4359.455068116486;4535.433070866142;4685.367475390779;4688.367070445514;4805.183118869801;9157.175854173156;9165.495897725688;9170.95414522923;9174.220191283683;9180.403273787182;5275.050490911673;5280.313559237275;5282.815101471507;5287.07476191665;5299.205119232146;4779.641526885497;4803.375561177025;4922.630802689812;4952.207646776498;4952.851414457572;3754.4743735877;3804.904877378088;3808.5810560838286;3851.30676478231;3888.2223555288488;1163.9709007274716;1195.384377045822;1212.7331986962854;1226.4113225651738;1239.913206075566;974.4640447753707;992.0971915556809;996.3274789517047;1007.561710655867;1011.0243614911645;5781.88436231273;5828.300603927556;5831.708414579254;5843.328017278068;5859.033259512218;987.2082170859867;992.6426486464867;999.1507218863908;1004.4977511244377;1013.3210748798323;3976.165005348851;4020.135670830727;4106.1582375612925;4187.413762073312;4194.832206711759;9968.102870741523;10064.496775161213;10299.845502317472;10386.42874641902;10403.167746580255;10292.485375731183;10315.587376505006;10317.226208034428;10318.587256509805;10321.48392580383;7853.371730261565;7955.721549745731;7971.880421793678;8024.679012839538;8041;5732.369439361751;5748.856278593069;5781.855453613525;5864.501517371071;5879.823605291848;9478.526073696425;9660.082292182231;9690.70927872165;9730.464824434725;9732.951335243279;9073.228775554151;9464.574094165642;9480.194183494204;9760.46317452547;9764.85352719724;7626.428017898569;7796.415268854745;7796.571188584456;7797.493162944391;7801.375889928679;8107.067687216046;8107.189281072082;8158;8180.977377827771;8191.549464779494;7270.272972702687;7390.556566606021;7464.440166987389;7505;7531.020967274439;7185.209626940928;7253.673584688807;7253.854922901407;7383.335499805044;7527.510711803715;6913.446924245947;6998.125234345707;7021.332973367522;7030.964845175741;7031.261717519791;5042.672226305279;5077;5137.743112844418;5162.225666150108;5334.919976200437;5002.374703162105;5076.695398276115;5101.413337466239;5115.900081482499;5196.090684130338 03:50:19 INFO - PROCESS | 20200 | |4;prototype.html;352.62621621081655;361.33514333626124;362.925600251948;364.1079355578832;369.81290058910895;5230.790768369261;5308.203769434586;5391;5476;5505.80729674461;5219.616801547593;5334.253204551366;5336.493033161853;5348.598855085865;5364.383095943967;4218.599233072869;4222.662187025046;4228.154369126171;4237.978810105945;4240.36394540819;4151.149014452045;4199.4120823084795;4209.452771139748;4239.491261048678;4262.850800221993;4177.770222637754;4192.643625291854;4192.685548583853;4201.907504048954;4210.831566737327;4185.2421982767155;4185.581441855806;4200.424840684743;4204.873853784391;4222.936655950163;3764.5294338207723;3766.3428091639867;3782.678472329828;3782.924341513154;3786.318462676717;5052.292679024939;5243.318368612094;5284.445133260991;5304.496072873071;5322.600804939606;4882;4887.608991280689;4891.902161956741;4899.730514821684;4901.779419926112;5351.304330437058;5627.184058311522;5648.181013752983;5661.716914154317;5702.315722113373;4095.8361665533344;4113.773742444165;4125.133721918401;4127.360259159805;4135.007598176416;5762.049261871786;5832.329282132567;5870.823875283706;5874.412558744134;5878.706064696748;4075.1849630074103;4179.665626749914;4209.789510524462;4232.322828347511;4249.1501699659575;4240.448741663626;4256.212600668824;4258.936115958263;4282.914341713211;4299.118680670517;4832.685875418087;4847.297141914473;4856.688694052586;4857.854264372075;4868.683535570177;5585.273914391103;5628.183913332544;5665.886682266331;5669.716514174274;5726.59698373901;1435.3110506956718;1436.3823555870867;1441.243347242706;1441.8053562768891;1444.5160871108296;967.264878692199;987.2299606307092;999.9050090241416;1001.6444162322271;1010.3331801011444;5399.244105825109;5411.431799661058;5412.619781955576;5412.621116521806;5422.810201643002;5608.719564021782;5612.316305108451;5639.774409023593;5646.825972000727;5684.516816070598;5084.669496482717;5320.920186197211;5336.46635336471;5352.625316227826;5362.436944120889;2970.495015847311;2973.468663638228;2976.866041028159;2985;2996.1011696490964;5660.8867822643315;5699.914501282484;5798.911767204111;5806.535477161817;5821.505172060338;5539.41836107211;5888.9705551472825;5918.615290006136;5930.703464826742;5932.851678708067;6021.3677563856045;6051.788187413419;6073.787417440369;6084.847878802977;6087.969560152171;5648.604597678287;5842.970785146047;5844.503217226414;5878.382769809279;5886.941130588811;5777.966567552069;5786.768529258951;5788.768449261982;5802.82591522255;5808.419158084158;5880.117982302689;6071.514278857592;6074.635521868702;6094.75620975156;6099.359567245376;4004.899877503086;4108.77401742907;4113.9794301028305;4146.937795933124;4164;5646.576506761927;5678.886422271614;5680.233168522197;5854;5866.882662346815;5742.36833948257;5753.482186603226;5776.133579963039;5785.095060833836;5874.295084589877;5528.226048353315;5674;5699.0311647020935;5703.885922281448;5712.80005199816;5614.382417934105;5625.268715067015;5627.56497093255;5655.971720141373;5736.4550367715;5521.199426083276;5693.146028095819;5697.23087383198;5706.42935706426;5745.339285982165;5546.861328466821;5567.081431563746;5587.094710750306;5593.769370738593;5605.159226116115 03:50:19 INFO - PROCESS | 20200 | |5;yui.html;804.3082948664152;809.1180613131685;815.2784785464862;823.4606332851981;877.1842186766305;15143.394264229431;15313.310901009454;15380.230988450574;15503.224838758046;15531.068135911839;14375.137491750502;14383.568492945202;14580.635484112903;14742.557723268319;14920.328585213665;740.5778706137504;751.6542390500376;853.4665833853857;861;861.336770686571;847.5507980770202;874.396666300254;878.7056336127373;879.0418443896152;881.3389957531851;910.3081657939947;915.4598786715836;916.4776077635751;917.0416914324547;917.179124683408;757.3486801350834;775.0892701076212;908.8409528332548;909.56340956341;909.963601455941;652.6051738698067;664.3754870421789;667.7262322447773;668.3550373889171;668.4251543672486;14838;14852.70294594102;14870.479533216394;14901.254937253094;14904.105753654816;14207.289635518182;14422.639434014129;14472.782908256384;14492.20292883891;14519.128852268897;12977.286249256287;13163.210207387587;13208.735825283537;13291.933540332333;13399.12905661129;4315.4605674290715;4322.632576231024;4368.235558777233;4396.340548917656;4458.3535387368975;60705;62768.99999999954;64078.679606602134;65107.674461627386;65343.3465665342;11102.2783519071;11275.154363422776;11341.886581134248;11437.771244575062;11648.359340236198;20826.37520874376;20838.479038023866;20839.687404688942;20842.270520532013;20853.37439876806;8485.278751306085;8563.186497282748;8852.690155844643;8864.955675221583;9012.684556040507;4653.86038418848;4669.39297891272;4681.6020638245445;4790.281457781361;5082.618803589746;3292.2921571862166;3346.849391777327;3374.5613070300706;3378.45944648855;3388.9830550847087;567.3532173322416;567.7416775367197;584.4681339980682;585.1515302810941;592.9407059294123;602.4878852975024;602.9990216241018;620.2247191011236;623.305014908383;630.7287866217571;9003.54982250898;9117.589708463134;9312.394694344981;9594;9669.613215471303;716.8888822232562;722.6350692900052;724.2540183610784;732.373820383575;759.7986533568609;4471.195184866755;4486.6186374157905;4560.383780878611;4569.908601828011;4679.3916790816975;52147.21779173316;53154.7342263294;54167.72916135473;54334.45665543373;89762;46804.06391872143;55395.16907246395;72007;72165.27834721586;72186;43119.78440107779;44689;45235.547644523795;70868;71532.2846771536;9962;10740;10748.731281718019;10812.513436895515;10844.566217351217;44163.337549936135;44288.33567496554;44398.778006109766;45223.7738811317;45435.318470222315;57311;58234.70882645559;60036.39963600308;61569;63673.363266366745;13188.498911749633;13324.533641322507;13387.665308367368;13466.93266533661;13501.59495215145;14734.705305894036;14831.555053348417;14850.777238341218;14998.850011500183;15307.311170997109;13695.520656776966;14773.92613036928;14939.402423903357;14954.476593319181;14968.775468367765;13105.541306054241;13157.802632960322;13867.930660346634;14124.78812817829;14343.928280358532;13507.122037067558;13832.377543010387;13958.651033723832;14031.368588413341;14337.856621433652;11400.600978965696;11616;11917.76164476723;12009.63971080869;12272.938635306766;11927.522899083939;12029.699257518281;12110.818337725117;12340.938295308466;12433.005359571394 03:50:19 INFO - PROCESS | 20200 | __end_tp_report 03:50:19 INFO - PROCESS | 20200 | __start_cc_report 03:50:19 INFO - PROCESS | 20200 | _x_x_mozilla_cycle_collect,1077 03:50:19 INFO - PROCESS | 20200 | __end_cc_report 03:50:19 INFO - PROCESS | 20200 | __startTimestamp1480161019495__endTimestamp 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | ------- Summary: start ------- 03:50:19 INFO - PROCESS | 20200 | Number of tests: 6 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#0] dojo.html Cycles:165 Average:5607.35 Median:5837.94 stddev:626.84 (10.7%) stddev-sans-first:600.15 03:50:19 INFO - PROCESS | 20200 | Values: 3220.6 3265.2 3270.8 3287.2 3296.3 5532.4 5626.4 5630.7 5633.8 5635.6 5644.8 5709.7 5710.4 5719.7 5749.2 5100.2 5110.7 5146.4 5153.7 5184.8 5056.0 5059.4 5179.4 5184.9 5191.6 5046.1 5065.3 5080.9 5095.0 5098.2 5130.1 5143.0 5212.1 5221.4 5253.6 4865.3 5125.4 5146.3 5188.4 5207.7 5420.2 5464.0 5484.9 5493.0 5572.1 5891.9 5901.0 5989.9 5996.1 6008.8 5908.6 6047.7 6062.7 6075.3 6080.9 5561.2 5561.4 5605.7 5618.4 5629.9 6144.4 6157.2 6170.7 6173.7 6179.4 5695.9 5925.1 5933.7 5936.5 5936.6 5810.4 5903.4 5953.6 5955.2 6031.7 5976.5 5984.4 5992.3 5994.2 6027.8 5939.0 5988.1 5998.1 6011.2 6012.2 4619.1 4623.5 4626.1 4664.4 4679.4 4172.4 4194.1 4203.7 4227.7 4237.6 5829.4 5829.6 5833.9 5837.9 5852.3 5906.0 5961.4 6011.6 6048.5 6138.9 5818.0 5824.6 5825.2 5829.4 5861.1 5261.5 5264.2 5266.8 5267.2 5270.7 6117.1 6131.4 6149.0 6315.0 6340.8 5953.9 6075.3 6079.1 6102.9 6109.6 6229.3 6293.2 6297.5 6297.9 6302.5 5736.2 5737.6 5936.3 5958.5 5994.3 5995.3 6027.3 6038.6 6111.8 6134.5 5956.5 6006.0 6012.0 6013.4 6041.3 5721.4 5968.3 5971.3 5980.0 5990.9 5784.8 5804.7 5852.0 5853.1 5902.4 5946.6 5952.7 5953.0 5964.7 5973.9 5644.0 5681.8 5709.5 5838.4 5855.9 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#1] ext.html Cycles:180 Average:50467.65 Median:21166.94 stddev:85495.64 (403.9%) stddev-sans-first:85653.42 03:50:19 INFO - PROCESS | 20200 | Values: 579.4 627.0 639.0 661.4 673.8 34647.0 35266.3 37908.8 44902.0 46065.8 48266.3 48700.0 48797.3 48815.0 48841.8 8875.0 9027.9 9028.6 9033.2 9033.9 8497.8 8689.0 8828.2 8921.6 10505.6 10525.2 10827.1 10834.8 10847.7 10854.6 10634.8 10671.5 10672.9 10701.9 10704.5 10600.2 10612.4 10617.5 10673.0 10707.8 44990.3 45330.0 45356.1 45386.5 45474.0 3548.3 3914.3 4203.6 4208.5 4220.4 31789.7 31834.5 32000.4 32285.4 32424.8 4025.6 4152.1 4168.5 4168.8 4178.3 348310.0 348748.0 350105.0 350220.0 350569.0 63765.7 63788.7 64000.4 64000.7 64043.4 40371.2 40768.4 41012.0 43475.1 69853.7 19807.0 20059.2 20093.3 20112.3 20129.2 13598.0 13645.4 13653.0 13657.7 13664.3 18941.3 19281.9 20251.9 20821.4 20895.5 7483.6 7516.7 7632.3 7660.5 7666.6 944.2 1049.5 1101.7 1139.1 1150.0 33437.3 33851.5 33886.0 34087.7 35164.6 1103.0 1172.2 1191.0 1200.9 1283.1 16805.8 17702.0 17732.5 17815.0 17977.4 170714.1 172107.0 172185.0 172355.1 173375.0 63061.0 63751.0 63923.7 63935.7 64032.4 1417.1 1433.0 1445.5 1446.4 1449.5 32157.0 33495.5 33647.3 33983.6 34034.5 55611.4 55844.4 55900.2 56010.7 56119.0 404957.0 405916.0 406020.0 406345.0 407015.0 31212.5 31840.4 31853.4 32487.8 33289.8 47948.6 48368.8 48445.0 48607.5 51764.5 40747.6 42928.0 43306.4 43374.6 45347.5 43980.8 44572.0 44803.3 45176.3 45899.3 43654.6 44318.0 44929.6 45058.3 46455.5 36867.6 38419.6 40223.8 40238.4 40485.0 29724.1 30001.8 30046.7 30256.4 30480.1 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#2] jquery.html Cycles:180 Average:30715.04 Median:2552.71 stddev:88076.30 (3450.3%) stddev-sans-first:88293.96 03:50:19 INFO - PROCESS | 20200 | Values: 398.0 408.5 429.8 432.8 440.4 15498.8 19590.1 20475.8 21023.5 21405.5 19550.3 20187.6 20189.0 20262.7 20580.8 5556.7 5833.0 5834.9 5834.9 5835.0 5637.2 5866.9 5890.6 5978.0 5983.5 5695.6 5947.9 5956.7 5972.6 5982.4 5865.3 6033.3 6047.3 6052.0 6059.0 5652.9 5830.9 5836.0 5840.1 5882.3 15147.0 15365.8 15482.7 21916.6 24035.2 2454.8 2474.0 2541.5 2563.9 2901.1 9698.1 10129.1 14828.1 15030.2 15216.9 1822.0 1894.3 1916.8 1937.9 1939.9 79197.0 84303.0 88503.6 89109.6 91902.0 10650.6 11555.5 11581.8 11602.9 12155.2 15536.9 15906.6 15922.7 15951.8 15974.7 8383.5 8411.9 9167.5 9251.4 9368.6 7704.0 8618.4 8668.2 8803.5 8927.3 4697.5 4984.4 5096.9 5108.8 5207.3 1875.7 1962.8 2077.9 2129.0 2146.8 927.8 981.6 1003.6 1008.3 1033.5 20407.8 20424.4 20517.2 20598.0 20858.9 998.8 999.1 1036.1 1041.9 1058.1 10660.8 11566.5 11636.2 11660.0 11670.2 519722.0 529194.0 537122.0 542412.0 546695.0 89365.6 90057.5 90985.1 93326.0 93562.5 1012.6 1025.9 1056.3 1058.3 1060.0 17787.6 17805.8 18382.8 18585.2 18638.4 42838.0 43797.6 43812.3 44718.3 45322.5 57392.7 58921.4 61410.4 61649.0 62271.0 8064.2 8356.8 8445.1 8736.9 9127.8 10206.8 13836.7 14233.4 14415.1 14822.6 12186.5 12197.7 12629.9 12633.0 12714.7 6870.6 8253.6 12095.6 12270.1 12564.8 12000.0 12185.4 12212.3 12306.6 12375.0 8404.1 8522.6 8554.9 8630.5 8684.7 11105.2 11663.0 12000.3 12233.7 12570.4 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#3] mootools.html Cycles:180 Average:5607.88 Median:5179.16 stddev:3033.02 (58.6%) stddev-sans-first:3025.53 03:50:19 INFO - PROCESS | 20200 | Values: 1462.9 1507.5 1569.5 1708.1 1713.7 7562.3 7739.9 7869.4 8480.7 8484.8 7828.8 8086.2 8101.0 8325.7 8336.2 2376.8 2400.5 2402.1 2406.7 2409.0 2173.2 2240.8 2398.0 2431.4 2457.8 2343.9 2429.5 2430.5 2436.2 2448.4 2344.8 2397.0 2407.3 2410.3 2427.1 2386.1 2395.9 2417.2 2418.2 2459.7 8530.9 8573.0 8591.9 8602.2 8608.0 5271.6 5397.8 5405.3 5408.4 5411.6 3366.3 3370.2 3403.1 3419.8 3473.5 1108.2 1115.5 1153.1 1155.4 1179.3 11287.9 11337.1 11371.4 11392.7 11400.8 4359.5 4535.4 4685.4 4688.4 4805.2 9157.2 9165.5 9171.0 9174.2 9180.4 5275.1 5280.3 5282.8 5287.1 5299.2 4779.6 4803.4 4922.6 4952.2 4952.9 3754.5 3804.9 3808.6 3851.3 3888.2 1164.0 1195.4 1212.7 1226.4 1239.9 974.5 992.1 996.3 1007.6 1011.0 5781.9 5828.3 5831.7 5843.3 5859.0 987.2 992.6 999.2 1004.5 1013.3 3976.2 4020.1 4106.2 4187.4 4194.8 9968.1 10064.5 10299.8 10386.4 10403.2 10292.5 10315.6 10317.2 10318.6 10321.5 7853.4 7955.7 7971.9 8024.7 8041.0 5732.4 5748.9 5781.9 5864.5 5879.8 9478.5 9660.1 9690.7 9730.5 9733.0 9073.2 9464.6 9480.2 9760.5 9764.9 7626.4 7796.4 7796.6 7797.5 7801.4 8107.1 8107.2 8158.0 8181.0 8191.5 7270.3 7390.6 7464.4 7505.0 7531.0 7185.2 7253.7 7253.9 7383.3 7527.5 6913.4 6998.1 7021.3 7031.0 7031.3 5042.7 5077.0 5137.7 5162.2 5334.9 5002.4 5076.7 5101.4 5115.9 5196.1 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#4] prototype.html Cycles:180 Average:4767.28 Median:5395.12 stddev:1392.30 (25.8%) stddev-sans-first:1356.21 03:50:19 INFO - PROCESS | 20200 | Values: 352.6 361.3 362.9 364.1 369.8 5230.8 5308.2 5391.0 5476.0 5505.8 5219.6 5334.3 5336.5 5348.6 5364.4 4218.6 4222.7 4228.2 4238.0 4240.4 4151.1 4199.4 4209.5 4239.5 4262.9 4177.8 4192.6 4192.7 4201.9 4210.8 4185.2 4185.6 4200.4 4204.9 4222.9 3764.5 3766.3 3782.7 3782.9 3786.3 5052.3 5243.3 5284.4 5304.5 5322.6 4882.0 4887.6 4891.9 4899.7 4901.8 5351.3 5627.2 5648.2 5661.7 5702.3 4095.8 4113.8 4125.1 4127.4 4135.0 5762.0 5832.3 5870.8 5874.4 5878.7 4075.2 4179.7 4209.8 4232.3 4249.2 4240.4 4256.2 4258.9 4282.9 4299.1 4832.7 4847.3 4856.7 4857.9 4868.7 5585.3 5628.2 5665.9 5669.7 5726.6 1435.3 1436.4 1441.2 1441.8 1444.5 967.3 987.2 999.9 1001.6 1010.3 5399.2 5411.4 5412.6 5412.6 5422.8 5608.7 5612.3 5639.8 5646.8 5684.5 5084.7 5320.9 5336.5 5352.6 5362.4 2970.5 2973.5 2976.9 2985.0 2996.1 5660.9 5699.9 5798.9 5806.5 5821.5 5539.4 5889.0 5918.6 5930.7 5932.9 6021.4 6051.8 6073.8 6084.8 6088.0 5648.6 5843.0 5844.5 5878.4 5886.9 5778.0 5786.8 5788.8 5802.8 5808.4 5880.1 6071.5 6074.6 6094.8 6099.4 4004.9 4108.8 4114.0 4146.9 4164.0 5646.6 5678.9 5680.2 5854.0 5866.9 5742.4 5753.5 5776.1 5785.1 5874.3 5528.2 5674.0 5699.0 5703.9 5712.8 5614.4 5625.3 5627.6 5656.0 5736.5 5521.2 5693.1 5697.2 5706.4 5745.3 5546.9 5567.1 5587.1 5593.8 5605.2 03:50:19 INFO - PROCESS | 20200 | 03:50:19 INFO - PROCESS | 20200 | [#5] yui.html Cycles:180 Average:16665.44 Median:24855.20 stddev:19925.42 (80.2%) stddev-sans-first:19945.72 03:50:19 INFO - PROCESS | 20200 | Values: 804.3 809.1 815.3 823.5 877.2 15143.4 15313.3 15380.2 15503.2 15531.1 14375.1 14383.6 14580.6 14742.6 14920.3 740.6 751.7 853.5 861.0 861.3 847.6 874.4 878.7 879.0 881.3 910.3 915.5 916.5 917.0 917.2 757.3 775.1 908.8 909.6 910.0 652.6 664.4 667.7 668.4 668.4 14838.0 14852.7 14870.5 14901.3 14904.1 14207.3 14422.6 14472.8 14492.2 14519.1 12977.3 13163.2 13208.7 13291.9 13399.1 4315.5 4322.6 4368.2 4396.3 4458.4 60705.0 62769.0 64078.7 65107.7 65343.3 11102.3 11275.2 11341.9 11437.8 11648.4 20826.4 20838.5 20839.7 20842.3 20853.4 8485.3 8563.2 8852.7 8865.0 9012.7 4653.9 4669.4 4681.6 4790.3 5082.6 3292.3 3346.8 3374.6 3378.5 3389.0 567.4 567.7 584.5 585.2 592.9 602.5 603.0 620.2 623.3 630.7 9003.5 9117.6 9312.4 9594.0 9669.6 716.9 722.6 724.3 732.4 759.8 4471.2 4486.6 4560.4 4569.9 4679.4 52147.2 53154.7 54167.7 54334.5 89762.0 46804.1 55395.2 72007.0 72165.3 72186.0 43119.8 44689.0 45235.5 70868.0 71532.3 9962.0 10740.0 10748.7 10812.5 10844.6 44163.3 44288.3 44398.8 45223.8 45435.3 57311.0 58234.7 60036.4 61569.0 63673.4 13188.5 13324.5 13387.7 13466.9 13501.6 14734.7 14831.6 14850.8 14998.9 15307.3 13695.5 14773.9 14939.4 14954.5 14968.8 13105.5 13157.8 13867.9 14124.8 14343.9 13507.1 13832.4 13958.7 14031.4 14337.9 11400.6 11616.0 11917.8 12009.6 12272.9 11927.5 12029.7 12110.8 12340.9 12433.0 03:50:19 INFO - PROCESS | 20200 | -------- Summary: end -------- 03:50:19 INFO - PROCESS | 20200 | 03:50:20 INFO - TEST-INFO | 20200: exit 0 03:50:20 INFO - TEST-OK | dromaeo_css | took 1115868ms 03:50:20 INFO - TEST-START | kraken 03:50:20 INFO - operating with platform_type : linux_ 03:50:20 INFO - Initialising browser for kraken test... 03:50:20 INFO - TEST-INFO | started process 20513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UUuB4/profile http://localhost:33542/getInfo.html) 03:50:24 INFO - PROCESS | 20513 | __metrics Screen width/height:1600/1200 03:50:24 INFO - PROCESS | 20513 | colorDepth:24 03:50:24 INFO - PROCESS | 20513 | Browser inner width/height: 1024/697 03:50:24 INFO - PROCESS | 20513 | __metrics 03:50:24 INFO - PROCESS | 20513 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:50:24 INFO - PROCESS | 20513 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:25 INFO - PROCESS | 20513 | console.error: PushService: 03:50:25 INFO - PROCESS | 20513 | stateChangeProcessEnqueue: Error transitioning state 03:50:25 INFO - PROCESS | 20513 | UnknownError 03:50:25 INFO - TEST-INFO | 20513: exit 0 03:50:25 INFO - Browser initialized. 03:50:25 INFO - Running cycle 1/1 for kraken test... 03:50:25 INFO - TEST-INFO | started process 20605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UUuB4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:37 INFO - PROCESS | 20605 | RSS: Main: 144596992 03:50:37 INFO - PROCESS | 20605 | 03:50:40 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33542/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:41 INFO - PROCESS | 20605 | RSS: Main: 185540608 03:50:41 INFO - PROCESS | 20605 | 03:50:43 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33542/tests/kraken/driver.html?testName=audio-dft) 03:50:44 INFO - PROCESS | 20605 | RSS: Main: 175030272 03:50:44 INFO - PROCESS | 20605 | 03:50:46 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33542/tests/kraken/driver.html?testName=audio-fft) 03:50:47 INFO - PROCESS | 20605 | RSS: Main: 266280960 03:50:47 INFO - PROCESS | 20605 | 03:50:49 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33542/tests/kraken/driver.html?testName=audio-oscillator) 03:50:50 INFO - PROCESS | 20605 | RSS: Main: 172969984 03:50:50 INFO - PROCESS | 20605 | 03:50:52 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:52 INFO - PROCESS | 20605 | RSS: Main: 175439872 03:50:52 INFO - PROCESS | 20605 | 03:50:55 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33542/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:56 INFO - PROCESS | 20605 | RSS: Main: 214204416 03:50:56 INFO - PROCESS | 20605 | 03:50:59 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33542/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:00 INFO - PROCESS | 20605 | RSS: Main: 212938752 03:51:00 INFO - PROCESS | 20605 | 03:51:03 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33542/tests/kraken/driver.html?testName=json-parse-financial) 03:51:03 INFO - PROCESS | 20605 | RSS: Main: 211537920 03:51:03 INFO - PROCESS | 20605 | 03:51:05 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:05 INFO - PROCESS | 20605 | RSS: Main: 173641728 03:51:05 INFO - PROCESS | 20605 | 03:51:07 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:08 INFO - PROCESS | 20605 | RSS: Main: 180195328 03:51:08 INFO - PROCESS | 20605 | 03:51:09 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:10 INFO - PROCESS | 20605 | RSS: Main: 190136320 03:51:10 INFO - PROCESS | 20605 | 03:51:13 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:13 INFO - PROCESS | 20605 | RSS: Main: 192000000 03:51:13 INFO - PROCESS | 20605 | 03:51:16 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:17 INFO - PROCESS | 20605 | RSS: Main: 194330624 03:51:17 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | Cycle 1(1): loaded http://localhost:33542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33542/tests/kraken/driver.html?testName=ai-astar) 03:51:18 INFO - PROCESS | 20605 | RSS: Main: 244457472 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | __start_tp_report 03:51:18 INFO - PROCESS | 20605 | _x_x_mozilla_page_load 03:51:18 INFO - PROCESS | 20605 | _x_x_mozilla_page_load_details 03:51:18 INFO - PROCESS | 20605 | |i|pagename|runs| 03:51:18 INFO - PROCESS | 20605 | |0;ai-astar;102;111;111;111;112;111;110;111;113;111 03:51:18 INFO - PROCESS | 20605 | |1;audio-beat-detection;147;122;123;160;123;130;125;121;154;125 03:51:18 INFO - PROCESS | 20605 | |2;audio-dft;160;159;158;160;161;160;160;161;160;159 03:51:18 INFO - PROCESS | 20605 | |3;audio-fft;74;76;75;106;77;76;77;75;98;75 03:51:18 INFO - PROCESS | 20605 | |4;audio-oscillator;85;83;114;84;82;83;108;92;84;109 03:51:18 INFO - PROCESS | 20605 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;117 03:51:18 INFO - PROCESS | 20605 | |6;imaging-darkroom;145;146;146;145;146;146;147;146;145;146 03:51:18 INFO - PROCESS | 20605 | |7;imaging-desaturate;85;84;84;85;84;85;84;84;85;84 03:51:18 INFO - PROCESS | 20605 | |8;json-parse-financial;48;49;49;49;48;51;50;54;50;49 03:51:18 INFO - PROCESS | 20605 | |9;json-stringify-tinderbox;59;58;59;59;68;58;59;63;58;59 03:51:18 INFO - PROCESS | 20605 | |10;stanford-crypto-aes;75;74;75;74;76;76;77;75;75;75 03:51:18 INFO - PROCESS | 20605 | |11;stanford-crypto-ccm;128;126;127;130;133;129;130;122;164;145 03:51:18 INFO - PROCESS | 20605 | |12;stanford-crypto-pbkdf2;157;155;155;155;155;154;155;157;155;154 03:51:18 INFO - PROCESS | 20605 | |13;stanford-crypto-sha256-iterative;64;61;62;61;63;62;61;61;61;61 03:51:18 INFO - PROCESS | 20605 | __end_tp_report 03:51:18 INFO - PROCESS | 20605 | __start_cc_report 03:51:18 INFO - PROCESS | 20605 | _x_x_mozilla_cycle_collect,1612 03:51:18 INFO - PROCESS | 20605 | __end_cc_report 03:51:18 INFO - PROCESS | 20605 | __startTimestamp1480161078960__endTimestamp 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | ------- Summary: start ------- 03:51:18 INFO - PROCESS | 20605 | Number of tests: 14 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.02 (2.7%) stddev-sans-first:0.83 03:51:18 INFO - PROCESS | 20605 | Values: 102.0 111.0 111.0 111.0 112.0 111.0 110.0 111.0 113.0 111.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:127.50 stddev:14.79 (11.6%) stddev-sans-first:14.79 03:51:18 INFO - PROCESS | 20605 | Values: 147.0 122.0 123.0 160.0 123.0 130.0 125.0 121.0 154.0 125.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:51:18 INFO - PROCESS | 20605 | Values: 160.0 159.0 158.0 160.0 161.0 160.0 160.0 161.0 160.0 159.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.32 (14.9%) stddev-sans-first:11.73 03:51:18 INFO - PROCESS | 20605 | Values: 74.0 76.0 75.0 106.0 77.0 76.0 77.0 75.0 98.0 75.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.50 stddev:12.76 (15.3%) stddev-sans-first:13.25 03:51:18 INFO - PROCESS | 20605 | Values: 85.0 83.0 114.0 84.0 82.0 83.0 108.0 92.0 84.0 109.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 03:51:18 INFO - PROCESS | 20605 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:51:18 INFO - PROCESS | 20605 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 03:51:18 INFO - PROCESS | 20605 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 85.0 84.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.50 stddev:1.77 (3.6%) stddev-sans-first:1.76 03:51:18 INFO - PROCESS | 20605 | Values: 48.0 49.0 49.0 49.0 48.0 51.0 50.0 54.0 50.0 49.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.00 stddev:3.16 (5.4%) stddev-sans-first:3.33 03:51:18 INFO - PROCESS | 20605 | Values: 59.0 58.0 59.0 59.0 68.0 58.0 59.0 63.0 58.0 59.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 03:51:18 INFO - PROCESS | 20605 | Values: 75.0 74.0 75.0 74.0 76.0 76.0 77.0 75.0 75.0 75.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.00 stddev:12.33 (9.5%) stddev-sans-first:12.92 03:51:18 INFO - PROCESS | 20605 | Values: 128.0 126.0 127.0 130.0 133.0 129.0 130.0 122.0 164.0 145.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.00 stddev:1.03 (0.7%) stddev-sans-first:0.87 03:51:18 INFO - PROCESS | 20605 | Values: 157.0 155.0 155.0 155.0 155.0 154.0 155.0 157.0 155.0 154.0 03:51:18 INFO - PROCESS | 20605 | 03:51:18 INFO - PROCESS | 20605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.06 (1.7%) stddev-sans-first:0.73 03:51:18 INFO - PROCESS | 20605 | Values: 64.0 61.0 62.0 61.0 63.0 62.0 61.0 61.0 61.0 61.0 03:51:18 INFO - PROCESS | 20605 | -------- Summary: end -------- 03:51:18 INFO - PROCESS | 20605 | 03:51:20 INFO - TEST-INFO | 20605: exit 0 03:51:20 INFO - TEST-OK | kraken | took 59886ms 03:51:20 INFO - SUITE-END | took 1175s 03:51:20 INFO - Completed test suite (00:19:36) 03:51:20 INFO - javascript benchmark 03:51:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3220.613526376834, 3265.2489927316715, 3270.7710460267776, 3287.2110693433583, 3296.274819539702, 5532.419095994918, 5626.381098079208, 5630.7184640767955, 5633.774649014044, 5635.5773317001185, 5644.774209031634, 5709.71451427428, 5710.428957104287, 5719.742611582478, 5749.223854779603, 5100.183970564711, 5110.66780659256, 5146.433892271847, 5153.665011774241, 5184.792608295664, 5056.0, 5059.392872855244, 5179.404368497633, 5184.896302073957, 5191.610629202806, 5046.09170349337, 5065.341505604285, 5080.898382032357, 5095.0319439306595, 5098.235264710304, 5130.127878260705, 5143.048536020848, 5212.061828870802, 5221.373435187802, 5253.6322457428, 4865.270209468573, 5125.384953805567, 5146.253793200002, 5188.429272779991, 5207.713575753332, 5420.24116623673, 5464.016477034133, 5484.890302193974, 5493.0, 5572.0527510323345, 5891.852703682443, 5900.996830538776, 5989.9101513477335, 5996.070609055603, 6008.8497787555225, 5908.6454812710945, 6047.7278522466595, 6062.666553339564, 6075.33171351151, 6080.939190608082, 5561.221428999943, 5561.360443549003, 5605.663660180402, 5618.438156184349, 5629.8592535186945, 6144.354842741537, 6157.199564056644, 6170.6914654268, 6173.722182501798, 6179.412955769195, 5695.857603559944, 5925.081612350006, 5933.732982015819, 5936.465718085393, 5936.5844390892225, 5810.41895810424, 5903.35063143054, 5953.553483488756, 5955.166276721263, 6031.698415079229, 5976.491998180203, 5984.431479009487, 5992.31088424828, 5994.220751302303, 6027.78902738402, 5939.049752039653, 5988.131720900532, 5998.070299103646, 6011.248593925759, 6012.218411606463, 4619.076184763061, 4623.468301145344, 4626.074785043005, 4664.416947881515, 4679.3916790816975, 4172.3532852407925, 4194.140201258735, 4203.663706903501, 4227.725197862129, 4237.5762423758, 5829.387914269026, 5829.562782791223, 5833.941660583425, 5837.941620583825, 5852.268466441695, 5906.0, 5961.374055724174, 6011.609245399035, 6048.516118710492, 6138.938610613836, 5818.0, 5824.563157763185, 5825.1844741736195, 5829.387914268941, 5861.062230043172, 5261.526462618306, 5264.236685680631, 5266.8419947401635, 5267.183586544092, 5270.657407268515, 6117.051856962178, 6131.437835141539, 6149.046897730859, 6314.989601663804, 6340.778072767431, 5953.880922381615, 6075.301340345917, 6079.088136779518, 6102.877942441038, 6109.572329936862, 6229.345918678474, 6293.244810622755, 6297.496200303873, 6297.874042519215, 6302.527310451826, 5736.225609542658, 5737.627054241461, 5936.28764548257, 5958.523318134626, 5994.280686317496, 5995.250593675791, 6027.30685971119, 6038.607490513103, 6111.77406523465, 6134.528431832502, 5956.463918247206, 6006.0, 6012.038073908154, 6013.398660133952, 6041.305249896318, 5721.399253078367, 5968.283805943314, 5971.28344598651, 5980.0, 5990.910136347871, 5784.82645520635, 5804.738786754522, 5851.970740146272, 5853.0635098384055, 5902.380250073852, 5946.613470124428, 5952.672603006703, 5953.047512397996, 5964.671943043174, 5973.940260597512, 5644.012297847942, 5681.801136960186, 5709.486146246858, 5838.416158384128, 5855.94144058554], "value": 5565.735641139371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4466284698113, 627.0437582686403, 639.0159154901452, 661.3584822721958, 673.814700957237, 34647.0, 35266.2946741065, 37908.81045594775, 44902.0, 46065.7696711516, 48266.27600585994, 48700.0, 48797.26804097941, 48815.0, 48841.75579122108, 8874.955625221864, 9027.909720902806, 9028.638854445815, 9033.23217526511, 9033.909660903373, 8497.787555311104, 8689.0, 8828.24959878408, 8921.598528066253, 10505.6323028694, 10525.157987360994, 10827.133829293638, 10834.783304333909, 10847.67456976292, 10854.565817367296, 10634.840477392845, 10671.519781609768, 10672.893271067267, 10701.946490267577, 10704.464776761131, 10600.151987840954, 10612.363258204532, 10617.522211500424, 10673.03942645158, 10707.78584428315, 44990.32514512285, 45330.0, 45356.092878142255, 45386.54613453856, 45474.0, 3548.290341931624, 3914.256291304643, 4203.579642035772, 4208.516020657633, 4220.376395788577, 31789.682103178904, 31834.522482162785, 32000.359992800248, 32285.35429291401, 32424.83787581047, 4025.6075306881457, 4152.1280531088505, 4168.4923322047525, 4168.7707176105305, 4178.289690752579, 348310.0, 348748.0, 350105.0, 350220.0, 350569.0, 63765.681171593846, 63788.68105659442, 64000.35999640037, 64000.67999659972, 64043.35956640374, 40371.192576148314, 40768.38847417291, 41012.0, 43475.13049738987, 69853.65073174704, 19807.0, 20059.197632094845, 20093.296734614218, 20112.296069637494, 20129.194832206547, 13598.04813663054, 13645.38595763193, 13653.044286899822, 13657.726845463036, 13664.31678416095, 18941.337053203348, 19281.903590482238, 20251.898740506203, 20821.37535873926, 20895.477613059797, 7483.588402637907, 7516.736914207976, 7632.274933881273, 7660.463767536219, 7666.578338191342, 944.1738478831023, 1049.506731836036, 1101.719061639293, 1139.0887290167832, 1149.9540018399337, 33437.331253374796, 33851.4922276166, 33886.0, 34087.65912340894, 35164.64835351665, 1103.0403548912498, 1172.2497601535024, 1190.988090119105, 1200.9095998454268, 1283.1338846278725, 16805.831941680426, 17702.0, 17732.468025959242, 17815.0201738903, 17977.404574049928, 170714.14642926955, 172107.0, 172185.0, 172355.1382243081, 173375.0, 63061.0, 63751.0, 63923.68038159779, 63935.68032159809, 64032.35967640357, 1417.0930604413184, 1432.978505322421, 1445.544653434165, 1446.3852862533593, 1449.5361484324915, 32157.0, 33495.49756753699, 33647.32705345928, 33983.58055324836, 34034.489482658275, 55611.44388556063, 55844.44155558555, 55900.16149757838, 56010.71994640001, 56119.0, 404957.0, 405916.0, 406020.0, 406345.0, 407015.0, 31212.531812022382, 31840.36319273648, 31853.36293274075, 32487.837560812044, 33289.83355083209, 47948.60256987067, 48368.75815620899, 48445.0, 48607.5139248603, 51764.48235517597, 40747.59252407438, 42928.0, 43306.35040474458, 43374.566254337056, 45347.54652453433, 43980.78009610059, 44572.0, 44803.327950081424, 45176.32235516404, 45899.311510328036, 43654.56345436632, 44318.0, 44929.55070449254, 45058.32412513749, 46455.535444645124, 36867.63132368642, 38419.6158038416, 40223.79888100658, 40238.39642405425, 40485.0, 29724.108276751733, 30001.849990749906, 30046.699533005263, 30256.394872101995, 30480.085597432113], "value": 20589.053070257844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9801009949502, 408.4955080475612, 429.7915510977176, 432.8247059940723, 440.40325359138365, 15498.845011549882, 19590.118444669988, 20475.795242047592, 21023.47441313964, 21405.464863378424, 19550.31573894914, 20187.59624807503, 20189.0, 20262.696059559083, 20580.794192058074, 5556.749946252428, 5832.9708351458185, 5834.9124763128375, 5834.941650583503, 5834.970825145869, 5637.238972738689, 5866.941330586682, 5890.646561206341, 5978.013627751416, 5983.521318294548, 5695.629784064023, 5947.851303717398, 5956.7319470623925, 5972.581919265654, 5982.401759824026, 5865.325487568942, 6033.276006879202, 6047.274327080779, 6052.0, 6059.030555111183, 5652.886942261173, 5830.883382332329, 5835.9708201458725, 5840.094785308242, 5882.264716910387, 15147.015443996104, 15365.769513457195, 15482.690346193125, 21916.561668766695, 24035.158769443162, 2454.7667971542674, 2473.9628905566433, 2541.4789968056502, 2563.9359016024564, 2901.0571564241704, 9698.127168554793, 10129.13902318304, 14828.110313381232, 15030.248487575687, 15216.923915380352, 1821.9726704099448, 1894.3464504745841, 1916.7795703494137, 1937.903104844752, 1939.8739081959627, 79197.0, 84303.0, 88503.55748221283, 89109.55445222733, 91902.0, 10650.627228047137, 11555.537778488935, 11581.826272605918, 11602.883971160349, 12155.17672349137, 15536.92231538835, 15906.60233494172, 15922.681546369007, 15951.760723589156, 15974.680506389806, 8383.538905360141, 8411.873821892677, 9167.49578773174, 9251.398659087137, 9368.62525498986, 7704.0, 8618.39671223021, 8668.176523230282, 8803.471791692518, 8927.285817134614, 4697.530246975343, 4984.401871775338, 5096.923546146811, 5108.846734597968, 5207.29701490294, 1875.6998880179106, 1962.8233458988475, 2077.9376618701463, 2128.968065479019, 2146.8389870759756, 927.8051609162017, 981.5975450065439, 1003.6085926488676, 1008.2589296866797, 1033.534909290822, 20407.795922040885, 20424.367818362232, 20517.17931282762, 20598.0, 20858.895705521376, 998.825205589019, 999.0658734083655, 1036.1348274190984, 1041.9057694035043, 1058.0636137018794, 10660.786784264426, 11566.47950842214, 11636.185467017227, 11660.0, 11670.241434306912, 519722.0, 529194.0, 537122.0, 542412.0, 546695.0, 89365.55317223372, 90057.54971225101, 90985.09014909899, 93326.0, 93562.53218733863, 1012.579779391559, 1025.8563801067855, 1056.3450660590483, 1058.2856571813995, 1060.0406631998055, 17787.644247115244, 17805.821941780418, 18382.816171838644, 18585.16366763472, 18638.440846774618, 42838.0, 43797.562024379346, 43812.34281485844, 44718.329225061, 45322.54677453183, 57392.713036436224, 58921.410785891596, 61410.38589614047, 61649.0, 62271.0, 8064.193580641889, 8356.837457767362, 8445.113263107285, 8736.91263087361, 9127.77180570491, 10206.760748277195, 13836.654083647989, 14233.359498822785, 14415.063020903608, 14822.555323340317, 12186.512539498675, 12197.695057623276, 12629.926456251322, 12633.0, 12714.745705086032, 6870.587764734132, 8253.587320634064, 12095.57665481704, 12270.141090123605, 12564.811527827273, 12000.0, 12185.39073046362, 12212.267263964191, 12306.630801075982, 12375.0, 8404.117567655308, 8522.573871306535, 8554.91445085566, 8630.482171069756, 8684.652613895374, 11105.167112466435, 11663.0, 12000.279983201035, 12233.69415764613, 12570.43433045497], "value": 9546.113579857541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.919539425331, 1507.4723846653674, 1569.45069225771, 1708.1117818734267, 1713.726781846673, 7562.319391254786, 7739.922600773991, 7869.449138560296, 8480.745577632666, 8484.830303393928, 7828.8042798930055, 8086.231807978233, 8101.02787665481, 8325.666973321075, 8336.208060234268, 2376.8455050421753, 2400.531896280226, 2402.0511897800357, 2406.7352591214953, 2409.0484258717797, 2173.174193806359, 2240.7759224077545, 2397.988010059956, 2431.4043059450373, 2457.8402403843693, 2343.894524746382, 2429.4776623026046, 2430.4895971845935, 2436.2447641231274, 2448.424620214257, 2344.824138189643, 2397.041183526586, 2407.265783935899, 2410.337157281744, 2427.0534491548224, 2386.129062892032, 2395.8562486250707, 2417.16607770319, 2418.153646223825, 2459.7417271186628, 8530.872036919389, 8572.957135214347, 8591.914080859175, 8602.18279263469, 8607.956960215159, 5271.630985830993, 5397.78408863645, 5405.324334458192, 5408.4050754416985, 5411.567074634059, 3366.2762506061313, 3370.2248482848836, 3403.081168084628, 3419.829008549563, 3473.4616134499192, 1108.2131686502594, 1115.5036008976008, 1153.0948205658517, 1155.3775008037244, 1179.2511755035528, 11287.943560282229, 11337.1497137715, 11371.431428428628, 11392.715182120513, 11400.771984560346, 4359.455068116486, 4535.433070866142, 4685.367475390779, 4688.367070445514, 4805.183118869801, 9157.175854173156, 9165.495897725688, 9170.95414522923, 9174.220191283683, 9180.403273787182, 5275.050490911673, 5280.313559237275, 5282.815101471507, 5287.07476191665, 5299.205119232146, 4779.641526885497, 4803.375561177025, 4922.630802689812, 4952.207646776498, 4952.851414457572, 3754.4743735877, 3804.904877378088, 3808.5810560838286, 3851.30676478231, 3888.2223555288488, 1163.9709007274716, 1195.384377045822, 1212.7331986962854, 1226.4113225651738, 1239.913206075566, 974.4640447753707, 992.0971915556809, 996.3274789517047, 1007.561710655867, 1011.0243614911645, 5781.88436231273, 5828.300603927556, 5831.708414579254, 5843.328017278068, 5859.033259512218, 987.2082170859867, 992.6426486464867, 999.1507218863908, 1004.4977511244377, 1013.3210748798323, 3976.165005348851, 4020.135670830727, 4106.1582375612925, 4187.413762073312, 4194.832206711759, 9968.102870741523, 10064.496775161213, 10299.845502317472, 10386.42874641902, 10403.167746580255, 10292.485375731183, 10315.587376505006, 10317.226208034428, 10318.587256509805, 10321.48392580383, 7853.371730261565, 7955.721549745731, 7971.880421793678, 8024.679012839538, 8041.0, 5732.369439361751, 5748.856278593069, 5781.855453613525, 5864.501517371071, 5879.823605291848, 9478.526073696425, 9660.082292182231, 9690.70927872165, 9730.464824434725, 9732.951335243279, 9073.228775554151, 9464.574094165642, 9480.194183494204, 9760.46317452547, 9764.85352719724, 7626.428017898569, 7796.415268854745, 7796.571188584456, 7797.493162944391, 7801.375889928679, 8107.067687216046, 8107.189281072082, 8158.0, 8180.977377827771, 8191.549464779494, 7270.272972702687, 7390.556566606021, 7464.440166987389, 7505.0, 7531.020967274439, 7185.209626940928, 7253.673584688807, 7253.854922901407, 7383.335499805044, 7527.510711803715, 6913.446924245947, 6998.125234345707, 7021.332973367522, 7030.964845175741, 7031.261717519791, 5042.672226305279, 5077.0, 5137.743112844418, 5162.225666150108, 5334.919976200437, 5002.374703162105, 5076.695398276115, 5101.413337466239, 5115.900081482499, 5196.090684130338], "value": 4569.102337828335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.62621621081655, 361.33514333626124, 362.925600251948, 364.1079355578832, 369.81290058910895, 5230.790768369261, 5308.203769434586, 5391.0, 5476.0, 5505.80729674461, 5219.616801547593, 5334.253204551366, 5336.493033161853, 5348.598855085865, 5364.383095943967, 4218.599233072869, 4222.662187025046, 4228.154369126171, 4237.978810105945, 4240.36394540819, 4151.149014452045, 4199.4120823084795, 4209.452771139748, 4239.491261048678, 4262.850800221993, 4177.770222637754, 4192.643625291854, 4192.685548583853, 4201.907504048954, 4210.831566737327, 4185.2421982767155, 4185.581441855806, 4200.424840684743, 4204.873853784391, 4222.936655950163, 3764.5294338207723, 3766.3428091639867, 3782.678472329828, 3782.924341513154, 3786.318462676717, 5052.292679024939, 5243.318368612094, 5284.445133260991, 5304.496072873071, 5322.600804939606, 4882.0, 4887.608991280689, 4891.902161956741, 4899.730514821684, 4901.779419926112, 5351.304330437058, 5627.184058311522, 5648.181013752983, 5661.716914154317, 5702.315722113373, 4095.8361665533344, 4113.773742444165, 4125.133721918401, 4127.360259159805, 4135.007598176416, 5762.049261871786, 5832.329282132567, 5870.823875283706, 5874.412558744134, 5878.706064696748, 4075.1849630074103, 4179.665626749914, 4209.789510524462, 4232.322828347511, 4249.1501699659575, 4240.448741663626, 4256.212600668824, 4258.936115958263, 4282.914341713211, 4299.118680670517, 4832.685875418087, 4847.297141914473, 4856.688694052586, 4857.854264372075, 4868.683535570177, 5585.273914391103, 5628.183913332544, 5665.886682266331, 5669.716514174274, 5726.59698373901, 1435.3110506956718, 1436.3823555870867, 1441.243347242706, 1441.8053562768891, 1444.5160871108296, 967.264878692199, 987.2299606307092, 999.9050090241416, 1001.6444162322271, 1010.3331801011444, 5399.244105825109, 5411.431799661058, 5412.619781955576, 5412.621116521806, 5422.810201643002, 5608.719564021782, 5612.316305108451, 5639.774409023593, 5646.825972000727, 5684.516816070598, 5084.669496482717, 5320.920186197211, 5336.46635336471, 5352.625316227826, 5362.436944120889, 2970.495015847311, 2973.468663638228, 2976.866041028159, 2985.0, 2996.1011696490964, 5660.8867822643315, 5699.914501282484, 5798.911767204111, 5806.535477161817, 5821.505172060338, 5539.41836107211, 5888.9705551472825, 5918.615290006136, 5930.703464826742, 5932.851678708067, 6021.3677563856045, 6051.788187413419, 6073.787417440369, 6084.847878802977, 6087.969560152171, 5648.604597678287, 5842.970785146047, 5844.503217226414, 5878.382769809279, 5886.941130588811, 5777.966567552069, 5786.768529258951, 5788.768449261982, 5802.82591522255, 5808.419158084158, 5880.117982302689, 6071.514278857592, 6074.635521868702, 6094.75620975156, 6099.359567245376, 4004.899877503086, 4108.77401742907, 4113.9794301028305, 4146.937795933124, 4164.0, 5646.576506761927, 5678.886422271614, 5680.233168522197, 5854.0, 5866.882662346815, 5742.36833948257, 5753.482186603226, 5776.133579963039, 5785.095060833836, 5874.295084589877, 5528.226048353315, 5674.0, 5699.0311647020935, 5703.885922281448, 5712.80005199816, 5614.382417934105, 5625.268715067015, 5627.56497093255, 5655.971720141373, 5736.4550367715, 5521.199426083276, 5693.146028095819, 5697.23087383198, 5706.42935706426, 5745.339285982165, 5546.861328466821, 5567.081431563746, 5587.094710750306, 5593.769370738593, 5605.159226116115], "value": 4331.1542485154805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.3082948664152, 809.1180613131685, 815.2784785464862, 823.4606332851981, 877.1842186766305, 15143.394264229431, 15313.310901009454, 15380.230988450574, 15503.224838758046, 15531.068135911839, 14375.137491750502, 14383.568492945202, 14580.635484112903, 14742.557723268319, 14920.328585213665, 740.5778706137504, 751.6542390500376, 853.4665833853857, 861.0, 861.336770686571, 847.5507980770202, 874.396666300254, 878.7056336127373, 879.0418443896152, 881.3389957531851, 910.3081657939947, 915.4598786715836, 916.4776077635751, 917.0416914324547, 917.179124683408, 757.3486801350834, 775.0892701076212, 908.8409528332548, 909.56340956341, 909.963601455941, 652.6051738698067, 664.3754870421789, 667.7262322447773, 668.3550373889171, 668.4251543672486, 14838.0, 14852.70294594102, 14870.479533216394, 14901.254937253094, 14904.105753654816, 14207.289635518182, 14422.639434014129, 14472.782908256384, 14492.20292883891, 14519.128852268897, 12977.286249256287, 13163.210207387587, 13208.735825283537, 13291.933540332333, 13399.12905661129, 4315.4605674290715, 4322.632576231024, 4368.235558777233, 4396.340548917656, 4458.3535387368975, 60705.0, 62768.99999999954, 64078.679606602134, 65107.674461627386, 65343.3465665342, 11102.2783519071, 11275.154363422776, 11341.886581134248, 11437.771244575062, 11648.359340236198, 20826.37520874376, 20838.479038023866, 20839.687404688942, 20842.270520532013, 20853.37439876806, 8485.278751306085, 8563.186497282748, 8852.690155844643, 8864.955675221583, 9012.684556040507, 4653.86038418848, 4669.39297891272, 4681.6020638245445, 4790.281457781361, 5082.618803589746, 3292.2921571862166, 3346.849391777327, 3374.5613070300706, 3378.45944648855, 3388.9830550847087, 567.3532173322416, 567.7416775367197, 584.4681339980682, 585.1515302810941, 592.9407059294123, 602.4878852975024, 602.9990216241018, 620.2247191011236, 623.305014908383, 630.7287866217571, 9003.54982250898, 9117.589708463134, 9312.394694344981, 9594.0, 9669.613215471303, 716.8888822232562, 722.6350692900052, 724.2540183610784, 732.373820383575, 759.7986533568609, 4471.195184866755, 4486.6186374157905, 4560.383780878611, 4569.908601828011, 4679.3916790816975, 52147.21779173316, 53154.7342263294, 54167.72916135473, 54334.45665543373, 89762.0, 46804.06391872143, 55395.16907246395, 72007.0, 72165.27834721586, 72186.0, 43119.78440107779, 44689.0, 45235.547644523795, 70868.0, 71532.2846771536, 9962.0, 10740.0, 10748.731281718019, 10812.513436895515, 10844.566217351217, 44163.337549936135, 44288.33567496554, 44398.778006109766, 45223.7738811317, 45435.318470222315, 57311.0, 58234.70882645559, 60036.39963600308, 61569.0, 63673.363266366745, 13188.498911749633, 13324.533641322507, 13387.665308367368, 13466.93266533661, 13501.59495215145, 14734.705305894036, 14831.555053348417, 14850.777238341218, 14998.850011500183, 15307.311170997109, 13695.520656776966, 14773.92613036928, 14939.402423903357, 14954.476593319181, 14968.775468367765, 13105.541306054241, 13157.802632960322, 13867.930660346634, 14124.78812817829, 14343.928280358532, 13507.122037067558, 13832.377543010387, 13958.651033723832, 14031.368588413341, 14337.856621433652, 11400.600978965696, 11616.0, 11917.76164476723, 12009.63971080869, 12272.938635306766, 11927.522899083939, 12029.699257518281, 12110.818337725117, 12340.938295308466, 12433.005359571394], "value": 7259.455630173763, "unit": "score"}], "name": "dromaeo_css", "value": 7346.179397584194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 113.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 160.0, 123.0, 130.0, 125.0, 121.0, 154.0, 125.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 106.0, 77.0, 76.0, 77.0, 75.0, 98.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 114.0, 84.0, 82.0, 83.0, 108.0, 92.0, 84.0, 109.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 49.0, 49.0, 48.0, 51.0, 50.0, 54.0, 50.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 59.0, 68.0, 58.0, 59.0, 63.0, 58.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 74.0, 76.0, 76.0, 77.0, 75.0, 75.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 127.0, 130.0, 133.0, 129.0, 130.0, 122.0, 164.0, 145.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 155.0, 155.0, 155.0, 154.0, 155.0, 157.0, 155.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 61.0, 63.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1458.8000000000004, "alertThreshold": 2.0}]} 03:51:20 INFO - Return code: 0 03:51:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:20 INFO - # TBPL SUCCESS # 03:51:20 INFO - Running post-action listener: _resource_record_post_action 03:51:20 INFO - [mozharness: 2016-11-26 11:51:20.793930Z] Finished run-tests step (success) 03:51:20 INFO - Running post-run listener: _resource_record_post_run 03:51:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 357654528; Read time: 216; Write time: 217940 03:51:20 INFO - TinderboxPrint: CPU usage
13.0% 03:51:20 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 216 03:51:20 INFO - TinderboxPrint: I/O write bytes / time
357,654,528 / 217,940 03:51:20 INFO - TinderboxPrint: CPU idle
8,281.1 (87.0%) 03:51:20 INFO - TinderboxPrint: CPU user
1,188.0 (12.5%) 03:51:20 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107319296; Read time: 0; Write time: 70044 03:51:20 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249171968; Read time: 204; Write time: 147864 03:51:21 INFO - Running post-run listener: _upload_blobber_files 03:51:21 INFO - Blob upload gear active. 03:51:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:21 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 03:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:21 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:22 INFO - (blobuploader) - INFO - Done attempting. 03:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:23 INFO - (blobuploader) - INFO - Done attempting. 03:51:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:26 INFO - (blobuploader) - INFO - Done attempting. 03:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:26 INFO - Return code: 0 03:51:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793701b3f93cf04276065a5b44ead03d366eaeff1382eae43fc153e6fcd053ad8d139eb38fb012c3e979ae0f46c311c8d2f3545c4d915f337342b51cda29a9ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e456ae2d1e8c38f98015334e4c858bd6246a16fcd2772af6c646de74525fa838461d6173c573a6005f5d4027774e3f15159f007bba740f96ee2811769e1983c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353f4bfda9bd846f2e84400a95e85c199d6d3c499b5f248c27c2772d9c888f112cd31f9eca008716dca61b13cebc197b866f911bfc1528e849b30a1353ce3b4"} 03:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:26 INFO - Contents: 03:51:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793701b3f93cf04276065a5b44ead03d366eaeff1382eae43fc153e6fcd053ad8d139eb38fb012c3e979ae0f46c311c8d2f3545c4d915f337342b51cda29a9ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e456ae2d1e8c38f98015334e4c858bd6246a16fcd2772af6c646de74525fa838461d6173c573a6005f5d4027774e3f15159f007bba740f96ee2811769e1983c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353f4bfda9bd846f2e84400a95e85c199d6d3c499b5f248c27c2772d9c888f112cd31f9eca008716dca61b13cebc197b866f911bfc1528e849b30a1353ce3b4"} 03:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:26 INFO - Copying logs to upload dir... 03:51:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.148505 ========= master_lag: 0.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-26 03:51:26.957374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:26.962326) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793701b3f93cf04276065a5b44ead03d366eaeff1382eae43fc153e6fcd053ad8d139eb38fb012c3e979ae0f46c311c8d2f3545c4d915f337342b51cda29a9ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e456ae2d1e8c38f98015334e4c858bd6246a16fcd2772af6c646de74525fa838461d6173c573a6005f5d4027774e3f15159f007bba740f96ee2811769e1983c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353f4bfda9bd846f2e84400a95e85c199d6d3c499b5f248c27c2772d9c888f112cd31f9eca008716dca61b13cebc197b866f911bfc1528e849b30a1353ce3b4"} build_url:https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793701b3f93cf04276065a5b44ead03d366eaeff1382eae43fc153e6fcd053ad8d139eb38fb012c3e979ae0f46c311c8d2f3545c4d915f337342b51cda29a9ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e456ae2d1e8c38f98015334e4c858bd6246a16fcd2772af6c646de74525fa838461d6173c573a6005f5d4027774e3f15159f007bba740f96ee2811769e1983c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353f4bfda9bd846f2e84400a95e85c199d6d3c499b5f248c27c2772d9c888f112cd31f9eca008716dca61b13cebc197b866f911bfc1528e849b30a1353ce3b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:26.989992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:26.990306) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1480150246.217936-1922941827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:27.039536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:51:27.039834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:51:27.043146) ========= ========= Total master_lag: 1.07 =========