builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1483612267.34 results: success (0) buildid: 20170105004018 builduid: e7ec886f8516491a8b9dac27187e1e32 revision: 5af63cf90f2874f840c132461bff7f6130483362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.340895) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.341388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.341687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.356801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.357188) ========= 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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 02:31:07-- 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% 46.3M=0s 2017-01-05 02:31:07 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.483918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.484391) ========= 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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016269 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:07.535598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:31:07.536013) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5af63cf90f2874f840c132461bff7f6130483362 --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 5af63cf90f2874f840c132461bff7f6130483362 --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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 02:31:08,111 truncating revision to first 12 chars 2017-01-05 02:31:08,111 Setting DEBUG logging. 2017-01-05 02:31:08,111 attempt 1/10 2017-01-05 02:31:08,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5af63cf90f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 02:31:09,188 unpacking tar archive at: mozilla-aurora-5af63cf90f28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:31:08.921856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:08.922214) ========= script_repo_revision: 5af63cf90f2874f840c132461bff7f6130483362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:08.922628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:08.922918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:31:08.933528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-05 02:31:08.933952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:09 INFO - MultiFileLogger online at 20170105 02:31:09 in /builds/slave/test 02:31:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:31:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:09 INFO - {'append_to_log': False, 02:31:09 INFO - 'base_work_dir': '/builds/slave/test', 02:31:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:31:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:09 INFO - 'branch': 'Mozilla-Aurora', 02:31:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:09 INFO - 'config_files': ('talos/linux_config.py',), 02:31:09 INFO - 'default_actions': ('clobber', 02:31:09 INFO - 'read-buildbot-config', 02:31:09 INFO - 'download-and-extract', 02:31:09 INFO - 'populate-webroot', 02:31:09 INFO - 'create-virtualenv', 02:31:09 INFO - 'install', 02:31:09 INFO - 'run-tests'), 02:31:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:09 INFO - 'download_minidump_stackwalk': True, 02:31:09 INFO - 'download_symbols': 'ondemand', 02:31:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:09 INFO - 'installer_path': 'installer.exe', 02:31:09 INFO - 'log_level': 'info', 02:31:09 INFO - 'log_name': 'talos', 02:31:09 INFO - 'log_to_console': True, 02:31:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:09 INFO - 'opt_config_files': (), 02:31:09 INFO - 'pip_index': False, 02:31:09 INFO - 'sps_profile': False, 02:31:09 INFO - 'sps_profile_interval': 0, 02:31:09 INFO - 'suite': 'dromaeojs-e10s', 02:31:09 INFO - 'system_bits': '32', 02:31:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:09 INFO - 'title': 'talos-linux64-ix-011', 02:31:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:09 INFO - 'use_talos_json': True, 02:31:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:09 INFO - 'work_dir': 'build'} 02:31:09 INFO - [mozharness: 2017-01-05 10:31:09.605656Z] Running clobber step. 02:31:09 INFO - Running pre-action listener: _resource_record_pre_action 02:31:09 INFO - Running main action method: clobber 02:31:09 INFO - rmtree: /builds/slave/test/build 02:31:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:10 INFO - Running post-action listener: _resource_record_post_action 02:31:10 INFO - [mozharness: 2017-01-05 10:31:10.075427Z] Finished clobber step (success) 02:31:10 INFO - [mozharness: 2017-01-05 10:31:10.075528Z] Running read-buildbot-config step. 02:31:10 INFO - Running pre-action listener: _resource_record_pre_action 02:31:10 INFO - Running main action method: read_buildbot_config 02:31:10 INFO - Using buildbot properties: 02:31:10 INFO - { 02:31:10 INFO - "project": "", 02:31:10 INFO - "product": "firefox", 02:31:10 INFO - "script_repo_revision": "production", 02:31:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:31:10 INFO - "repository": "", 02:31:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:31:10 INFO - "buildid": "20170105004018", 02:31:10 INFO - "stage_platform": "linux64-pgo", 02:31:10 INFO - "basedir": "/builds/slave/test", 02:31:10 INFO - "nightly_build": "True", 02:31:10 INFO - "buildnumber": 787, 02:31:10 INFO - "slavename": "talos-linux64-ix-011", 02:31:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:31:10 INFO - "platform": "ubuntu64_hw", 02:31:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:31:10 INFO - "branch": "mozilla-aurora", 02:31:10 INFO - "repo_path": "releases/mozilla-aurora", 02:31:10 INFO - "revision": "5af63cf90f2874f840c132461bff7f6130483362", 02:31:10 INFO - "pgo_build": "True", 02:31:10 INFO - "builduid": "e7ec886f8516491a8b9dac27187e1e32", 02:31:10 INFO - "slavebuilddir": "test" 02:31:10 INFO - } 02:31:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:31:10 INFO - Running post-action listener: _resource_record_post_action 02:31:10 INFO - [mozharness: 2017-01-05 10:31:10.078039Z] Finished read-buildbot-config step (success) 02:31:10 INFO - [mozharness: 2017-01-05 10:31:10.078130Z] Running download-and-extract step. 02:31:10 INFO - Running pre-action listener: _resource_record_pre_action 02:31:10 INFO - Running main action method: download_and_extract 02:31:10 INFO - mkdir: /builds/slave/test/build/tests 02:31:10 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')]} 02:31:10 INFO - trying https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:10 INFO - Downloading https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/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 02:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/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 02:31:10 INFO - Downloaded 1361 bytes. 02:31:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:10 INFO - Using the following test package requirements: 02:31:10 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:10 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:10 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:31:10 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'jsshell-linux-x86_64.zip'], 02:31:10 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:10 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:10 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:31:10 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:31:10 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:10 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:10 INFO - Fetch https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:11 INFO - Http code: 200 02:31:11 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 02:31:11 INFO - x-amz-cf-id: 8mpIhZy5StLB6cbuBcFdBmISRnPhwzskU_rSNyR8HWFOxX-HzwuOAg== 02:31:11 INFO - x-amz-version-id: AnAuoE2jKMLRBxAQJtwvlWirlfbs.aHL 02:31:11 INFO - Expected file size: 21942907 02:31:11 INFO - Obtained file size: 21942907 02:31:15 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 02:31:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:15 INFO - Fetch https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:16 INFO - Http code: 200 02:31:16 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 02:31:16 INFO - x-amz-cf-id: Y_h4UHPA891Ad-494hjr6pNiio-aq0RULUah46JuKZ21phBWh5mhPw== 02:31:16 INFO - x-amz-version-id: AnAuoE2jKMLRBxAQJtwvlWirlfbs.aHL 02:31:16 INFO - Expected file size: 21942907 02:31:16 INFO - Obtained file size: 21942907 02:31:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:31:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:31:21 INFO - Fetch https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:31:21 INFO - Http code: 200 02:31:21 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 02:31:21 INFO - x-amz-cf-id: tl16x4XtTi-e-rXHa6aio6zUy2dMm_eRsug1bllzgWI9vbF6_xWe7g== 02:31:21 INFO - x-amz-version-id: Wn4cPVoxTq2W7Dkf14PzbERMd87TV1dk 02:31:22 INFO - Expected file size: 14409038 02:31:22 INFO - Obtained file size: 14409038 02:31:22 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')]} 02:31:22 INFO - trying https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/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 02:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/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 02:31:23 INFO - Downloaded 64059851 bytes. 02:31:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:23 INFO - mkdir: /builds/slave/test/properties 02:31:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:23 INFO - Contents: 02:31:23 INFO - build_url:https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:24 INFO - Running post-action listener: _resource_record_post_action 02:31:24 INFO - Running post-action listener: set_extra_try_arguments 02:31:24 INFO - [mozharness: 2017-01-05 10:31:24.127739Z] Finished download-and-extract step (success) 02:31:24 INFO - [mozharness: 2017-01-05 10:31:24.127966Z] Running populate-webroot step. 02:31:24 INFO - Running pre-action listener: _resource_record_pre_action 02:31:24 INFO - Running main action method: populate_webroot 02:31:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:31:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:31:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:31:24 INFO - '--tppagecycles', 02:31:24 INFO - '7'], 02:31:24 INFO - 'tests': ['tsvgm']}}, 02:31:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:31:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:31:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['damp', 'tps']}, 02:31:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'tests': ['damp', 'tps']}, 02:31:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['dromaeo_dom']}, 02:31:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['basic_compositor_video']}, 02:31:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:31:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['a11yr', 02:31:24 INFO - 'ts_paint', 02:31:24 INFO - 'tpaint', 02:31:24 INFO - 'sessionrestore', 02:31:24 INFO - 'sessionrestore_no_auto_restore', 02:31:24 INFO - 'tabpaint']}, 02:31:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['tsvgx', 02:31:24 INFO - 'tsvgr_opacity', 02:31:24 INFO - 'tart', 02:31:24 INFO - 'tscrollx', 02:31:24 INFO - 'cart']}, 02:31:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:24 INFO - 'tsvgr_opacity', 02:31:24 INFO - 'tart', 02:31:24 INFO - 'tscrollx', 02:31:24 INFO - 'cart']}, 02:31:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'talos_options': ['--disable-e10s'], 02:31:24 INFO - 'tests': ['tp5o']}, 02:31:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'tests': ['tp5o']}, 02:31:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'talos_options': ['--disable-e10s', 02:31:24 INFO - '--xperf_path', 02:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:24 INFO - 'tests': ['tp5n']}, 02:31:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:24 INFO - 'talos_options': ['--xperf_path', 02:31:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:24 INFO - 'tests': ['tp5n']}}, 02:31:24 INFO - 'talos.zip': {'path': '', 02:31:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:31:24 INFO - Running post-action listener: _resource_record_post_action 02:31:24 INFO - [mozharness: 2017-01-05 10:31:24.145277Z] Finished populate-webroot step (success) 02:31:24 INFO - [mozharness: 2017-01-05 10:31:24.145366Z] Running create-virtualenv step. 02:31:24 INFO - Running pre-action listener: _resource_record_pre_action 02:31:24 INFO - Running main action method: create_virtualenv 02:31:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:24 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 02:31:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:31:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:24 INFO - Using real prefix '/usr' 02:31:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:31:26 INFO - Installing pip.................done. 02:31:26 INFO - Return code: 0 02:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:31:26 INFO - Reading from file tmpfile_stdout 02:31:26 INFO - Output received: 02:31:26 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) 02:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:26 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 02:31:26 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 02:31:26 INFO - Using env: {'DISPLAY': ':0', 02:31:26 INFO - 'HOME': '/home/cltbld', 02:31:26 INFO - 'LANG': 'en_US.UTF-8', 02:31:26 INFO - 'LANGUAGE': 'en_US:en', 02:31:26 INFO - 'LOGNAME': 'cltbld', 02:31:26 INFO - 'MAIL': '/var/mail/cltbld', 02:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:26 INFO - 'MOZ_NO_REMOTE': '1', 02:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:26 INFO - 'NO_EM_RESTART': '1', 02:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:26 INFO - 'PWD': '/builds/slave/test', 02:31:26 INFO - 'SHELL': '/bin/bash', 02:31:26 INFO - 'SHLVL': '1', 02:31:26 INFO - 'TERM': 'linux', 02:31:26 INFO - 'TMOUT': '86400', 02:31:26 INFO - 'USER': 'cltbld', 02:31:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:26 INFO - '_': '/tools/buildbot/bin/python'} 02:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:27 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 02:31:27 INFO - Cleaning up... 02:31:27 INFO - Return code: 0 02:31:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02: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')]} 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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')]} 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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', '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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02: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 psutil>=3.1.1 02:31:27 INFO - Using env: {'DISPLAY': ':0', 02:31:27 INFO - 'HOME': '/home/cltbld', 02:31:27 INFO - 'LANG': 'en_US.UTF-8', 02:31:27 INFO - 'LANGUAGE': 'en_US:en', 02:31:27 INFO - 'LOGNAME': 'cltbld', 02:31:27 INFO - 'MAIL': '/var/mail/cltbld', 02:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:27 INFO - 'MOZ_NO_REMOTE': '1', 02:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:27 INFO - 'NO_EM_RESTART': '1', 02:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:27 INFO - 'PWD': '/builds/slave/test', 02:31:27 INFO - 'SHELL': '/bin/bash', 02:31:27 INFO - 'SHLVL': '1', 02:31:27 INFO - 'TERM': 'linux', 02:31:27 INFO - 'TMOUT': '86400', 02:31:27 INFO - 'USER': 'cltbld', 02:31:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:27 INFO - '_': '/tools/buildbot/bin/python'} 02:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:27 INFO - Downloading/unpacking psutil>=3.1.1 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:29 INFO - Installing collected packages: psutil 02:31:29 INFO - Running setup.py install for psutil 02:31:29 INFO - building 'psutil._psutil_linux' extension 02:31:29 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 02:31:29 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 02:31:29 INFO - building 'psutil._psutil_posix' extension 02:31:29 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 02:31:29 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 02:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:29 INFO - Successfully installed psutil 02:31:29 INFO - Cleaning up... 02:31:30 INFO - Return code: 0 02:31:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:31:30 INFO - Using env: {'DISPLAY': ':0', 02:31:30 INFO - 'HOME': '/home/cltbld', 02:31:30 INFO - 'LANG': 'en_US.UTF-8', 02:31:30 INFO - 'LANGUAGE': 'en_US:en', 02:31:30 INFO - 'LOGNAME': 'cltbld', 02:31:30 INFO - 'MAIL': '/var/mail/cltbld', 02:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:30 INFO - 'MOZ_NO_REMOTE': '1', 02:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:30 INFO - 'NO_EM_RESTART': '1', 02:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:30 INFO - 'PWD': '/builds/slave/test', 02:31:30 INFO - 'SHELL': '/bin/bash', 02:31:30 INFO - 'SHLVL': '1', 02:31:30 INFO - 'TERM': 'linux', 02:31:30 INFO - 'TMOUT': '86400', 02:31:30 INFO - 'USER': 'cltbld', 02:31:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:30 INFO - '_': '/tools/buildbot/bin/python'} 02:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:31:32 INFO - Installing collected packages: mozsystemmonitor 02:31:32 INFO - Running setup.py install for mozsystemmonitor 02:31:32 INFO - Successfully installed mozsystemmonitor 02:31:32 INFO - Cleaning up... 02:31:32 INFO - Return code: 0 02:31:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:32 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:32 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 02:31:32 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 02:31:32 INFO - Using env: {'DISPLAY': ':0', 02:31:32 INFO - 'HOME': '/home/cltbld', 02:31:32 INFO - 'LANG': 'en_US.UTF-8', 02:31:32 INFO - 'LANGUAGE': 'en_US:en', 02:31:32 INFO - 'LOGNAME': 'cltbld', 02:31:32 INFO - 'MAIL': '/var/mail/cltbld', 02:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:32 INFO - 'MOZ_NO_REMOTE': '1', 02:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:32 INFO - 'NO_EM_RESTART': '1', 02:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:32 INFO - 'PWD': '/builds/slave/test', 02:31:32 INFO - 'SHELL': '/bin/bash', 02:31:32 INFO - 'SHLVL': '1', 02:31:32 INFO - 'TERM': 'linux', 02:31:32 INFO - 'TMOUT': '86400', 02:31:32 INFO - 'USER': 'cltbld', 02:31:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:32 INFO - '_': '/tools/buildbot/bin/python'} 02:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:31:32 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 02:31:32 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 02:31:32 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 02:31:32 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 02:31:32 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 02:31:32 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 02:31:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:31:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:31:34 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 02:31:34 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 02:31:34 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 02:31:34 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 02:31:34 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 02:31:34 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 02:31:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:31:34 INFO - warning: no files found matching '*.txt' 02:31:34 INFO - no previously-included directories found matching 'build' 02:31:34 INFO - no previously-included directories found matching 'dist' 02:31:34 INFO - no previously-included directories found matching '.git*' 02:31:34 INFO - Installing collected packages: jsonschema, functools32 02:31:35 INFO - Running setup.py install for functools32 02:31:35 INFO - warning: no files found matching '*.txt' 02:31:35 INFO - no previously-included directories found matching 'build' 02:31:35 INFO - no previously-included directories found matching 'dist' 02:31:35 INFO - no previously-included directories found matching '.git*' 02:31:35 INFO - Successfully installed jsonschema functools32 02:31:35 INFO - Cleaning up... 02:31:35 INFO - Return code: 0 02:31:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:35 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 02:31:35 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 02:31:35 INFO - Using env: {'DISPLAY': ':0', 02:31:35 INFO - 'HOME': '/home/cltbld', 02:31:35 INFO - 'LANG': 'en_US.UTF-8', 02:31:35 INFO - 'LANGUAGE': 'en_US:en', 02:31:35 INFO - 'LOGNAME': 'cltbld', 02:31:35 INFO - 'MAIL': '/var/mail/cltbld', 02:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:35 INFO - 'MOZ_NO_REMOTE': '1', 02:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:35 INFO - 'NO_EM_RESTART': '1', 02:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:35 INFO - 'PWD': '/builds/slave/test', 02:31:35 INFO - 'SHELL': '/bin/bash', 02:31:35 INFO - 'SHLVL': '1', 02:31:35 INFO - 'TERM': 'linux', 02:31:35 INFO - 'TMOUT': '86400', 02:31:35 INFO - 'USER': 'cltbld', 02:31:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:35 INFO - '_': '/tools/buildbot/bin/python'} 02:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:31:35 INFO - Cleaning up... 02:31:35 INFO - Return code: 0 02:31:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:35 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 02:31:35 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 02:31:35 INFO - Using env: {'DISPLAY': ':0', 02:31:35 INFO - 'HOME': '/home/cltbld', 02:31:35 INFO - 'LANG': 'en_US.UTF-8', 02:31:35 INFO - 'LANGUAGE': 'en_US:en', 02:31:35 INFO - 'LOGNAME': 'cltbld', 02:31:35 INFO - 'MAIL': '/var/mail/cltbld', 02:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:35 INFO - 'MOZ_NO_REMOTE': '1', 02:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:35 INFO - 'NO_EM_RESTART': '1', 02:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:35 INFO - 'PWD': '/builds/slave/test', 02:31:35 INFO - 'SHELL': '/bin/bash', 02:31:35 INFO - 'SHLVL': '1', 02:31:35 INFO - 'TERM': 'linux', 02:31:35 INFO - 'TMOUT': '86400', 02:31:35 INFO - 'USER': 'cltbld', 02:31:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:35 INFO - '_': '/tools/buildbot/bin/python'} 02:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:31:35 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 02:31:35 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 02:31:35 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 02:31:35 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 02:31:35 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 02:31:35 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 02:31:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:38 INFO - Downloading docopt-0.6.1.tar.gz 02:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:31:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:31:38 INFO - Running setup.py install for blobuploader 02:31:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:31:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:31:38 INFO - Running setup.py install for requests 02:31:38 INFO - Running setup.py install for docopt 02:31:38 INFO - Successfully installed blobuploader requests docopt 02:31:38 INFO - Cleaning up... 02:31:39 INFO - Return code: 0 02:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:39 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:39 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 02:31:39 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 02:31:39 INFO - Using env: {'DISPLAY': ':0', 02:31:39 INFO - 'HOME': '/home/cltbld', 02:31:39 INFO - 'LANG': 'en_US.UTF-8', 02:31:39 INFO - 'LANGUAGE': 'en_US:en', 02:31:39 INFO - 'LOGNAME': 'cltbld', 02:31:39 INFO - 'MAIL': '/var/mail/cltbld', 02:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:39 INFO - 'MOZ_NO_REMOTE': '1', 02:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:39 INFO - 'NO_EM_RESTART': '1', 02:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:39 INFO - 'PWD': '/builds/slave/test', 02:31:39 INFO - 'SHELL': '/bin/bash', 02:31:39 INFO - 'SHLVL': '1', 02:31:39 INFO - 'TERM': 'linux', 02:31:39 INFO - 'TMOUT': '86400', 02:31:39 INFO - 'USER': 'cltbld', 02:31:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:39 INFO - '_': '/tools/buildbot/bin/python'} 02:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:39 INFO - Running setup.py (path:/tmp/pip-grlerJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:39 INFO - Running setup.py (path:/tmp/pip-O1oHGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:39 INFO - Running setup.py (path:/tmp/pip-wrDjFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:39 INFO - Running setup.py (path:/tmp/pip-dqGtL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:39 INFO - Running setup.py (path:/tmp/pip-ThYIjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:39 INFO - Running setup.py (path:/tmp/pip-kTZE9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:39 INFO - Running setup.py (path:/tmp/pip-aO4rFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:39 INFO - Running setup.py (path:/tmp/pip-CKzPJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:39 INFO - Running setup.py (path:/tmp/pip-koIXmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:39 INFO - Running setup.py (path:/tmp/pip-MbjKKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:39 INFO - Running setup.py (path:/tmp/pip-0OQQ2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:40 INFO - Running setup.py (path:/tmp/pip-M4G4IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:40 INFO - Running setup.py (path:/tmp/pip-zjoiL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:40 INFO - Running setup.py (path:/tmp/pip-Jy5mj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:40 INFO - Running setup.py (path:/tmp/pip-_ROwcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:40 INFO - Running setup.py (path:/tmp/pip-nFRrIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:40 INFO - Running setup.py (path:/tmp/pip-AfFk76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:31:40 INFO - Running setup.py install for manifestparser 02:31:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:31:40 INFO - Running setup.py install for mozcrash 02:31:40 INFO - Running setup.py install for mozdebug 02:31:40 INFO - Running setup.py install for mozdevice 02:31:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:31:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:31:40 INFO - Running setup.py install for mozfile 02:31:41 INFO - Running setup.py install for mozhttpd 02:31:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozinfo 02:31:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozInstall 02:31:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozleak 02:31:41 INFO - Running setup.py install for mozlog 02:31:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for moznetwork 02:31:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozprocess 02:31:41 INFO - Running setup.py install for mozprofile 02:31:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozrunner 02:31:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:31:41 INFO - Running setup.py install for mozscreenshot 02:31:42 INFO - Running setup.py install for moztest 02:31:42 INFO - Running setup.py install for mozversion 02:31:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:31:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:31:42 INFO - Cleaning up... 02:31:42 INFO - Return code: 0 02:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:42 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:42 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 02:31:42 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 02:31:42 INFO - Using env: {'DISPLAY': ':0', 02:31:42 INFO - 'HOME': '/home/cltbld', 02:31:42 INFO - 'LANG': 'en_US.UTF-8', 02:31:42 INFO - 'LANGUAGE': 'en_US:en', 02:31:42 INFO - 'LOGNAME': 'cltbld', 02:31:42 INFO - 'MAIL': '/var/mail/cltbld', 02:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:42 INFO - 'MOZ_NO_REMOTE': '1', 02:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:42 INFO - 'NO_EM_RESTART': '1', 02:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:42 INFO - 'PWD': '/builds/slave/test', 02:31:42 INFO - 'SHELL': '/bin/bash', 02:31:42 INFO - 'SHLVL': '1', 02:31:42 INFO - 'TERM': 'linux', 02:31:42 INFO - 'TMOUT': '86400', 02:31:42 INFO - 'USER': 'cltbld', 02:31:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:42 INFO - '_': '/tools/buildbot/bin/python'} 02:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:42 INFO - Running setup.py (path:/tmp/pip-eD_lYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:42 INFO - Running setup.py (path:/tmp/pip-EtbN1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:42 INFO - Running setup.py (path:/tmp/pip-aiAMQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:42 INFO - Running setup.py (path:/tmp/pip-NhUBUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:42 INFO - Running setup.py (path:/tmp/pip-ApRgqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:42 INFO - Running setup.py (path:/tmp/pip-UzYFw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:42 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)) 02:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:42 INFO - Running setup.py (path:/tmp/pip-fslTNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:43 INFO - Running setup.py (path:/tmp/pip-OIuaTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:43 INFO - Running setup.py (path:/tmp/pip-v3O0kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:43 INFO - Running setup.py (path:/tmp/pip-a7b_CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:43 INFO - Running setup.py (path:/tmp/pip-y4ynG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:43 INFO - Running setup.py (path:/tmp/pip-yFSTzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:43 INFO - Running setup.py (path:/tmp/pip-9STJHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:43 INFO - Running setup.py (path:/tmp/pip-ajMFgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:43 INFO - Running setup.py (path:/tmp/pip-_rrHqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:43 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:43 INFO - Running setup.py (path:/tmp/pip-GKzhb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:43 INFO - Running setup.py (path:/tmp/pip-JnQP4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:43 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)) 02:31:43 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)) 02:31:43 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)) 02:31:43 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)) 02:31:43 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)) 02:31:43 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)) 02:31:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:45 INFO - Downloading blessings-1.6.tar.gz 02:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:31:45 INFO - Installing collected packages: blessings 02:31:45 INFO - Running setup.py install for blessings 02:31:45 INFO - Successfully installed blessings 02:31:45 INFO - Cleaning up... 02:31:45 INFO - Return code: 0 02:31:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:46 INFO - Reading from file tmpfile_stdout 02:31:46 INFO - Current package versions: 02:31:46 INFO - argparse == 1.2.1 02:31:46 INFO - blessings == 1.6 02:31:46 INFO - blobuploader == 1.2.4 02:31:46 INFO - docopt == 0.6.1 02:31:46 INFO - functools32 == 3.2.3-2 02:31:46 INFO - jsonschema == 2.5.1 02:31:46 INFO - manifestparser == 1.1 02:31:46 INFO - mozInstall == 1.12 02:31:46 INFO - mozcrash == 1.0 02:31:46 INFO - mozdebug == 0.1 02:31:46 INFO - mozdevice == 0.48 02:31:46 INFO - mozfile == 1.2 02:31:46 INFO - mozhttpd == 0.7 02:31:46 INFO - mozinfo == 0.9 02:31:46 INFO - mozleak == 0.1 02:31:46 INFO - mozlog == 3.4 02:31:46 INFO - moznetwork == 0.27 02:31:46 INFO - mozprocess == 0.23 02:31:46 INFO - mozprofile == 0.28 02:31:46 INFO - mozrunner == 6.13 02:31:46 INFO - mozscreenshot == 0.1 02:31:46 INFO - mozsystemmonitor == 0.3 02:31:46 INFO - moztest == 0.8 02:31:46 INFO - mozversion == 1.4 02:31:46 INFO - psutil == 3.1.1 02:31:46 INFO - requests == 1.2.3 02:31:46 INFO - wsgiref == 0.1.2 02:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:46 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 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:46 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 02:31:46 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 02:31:46 INFO - Using env: {'DISPLAY': ':0', 02:31:46 INFO - 'HOME': '/home/cltbld', 02:31:46 INFO - 'LANG': 'en_US.UTF-8', 02:31:46 INFO - 'LANGUAGE': 'en_US:en', 02:31:46 INFO - 'LOGNAME': 'cltbld', 02:31:46 INFO - 'MAIL': '/var/mail/cltbld', 02:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:46 INFO - 'MOZ_NO_REMOTE': '1', 02:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:46 INFO - 'NO_EM_RESTART': '1', 02:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:46 INFO - 'PWD': '/builds/slave/test', 02:31:46 INFO - 'SHELL': '/bin/bash', 02:31:46 INFO - 'SHLVL': '1', 02:31:46 INFO - 'TERM': 'linux', 02:31:46 INFO - 'TMOUT': '86400', 02:31:46 INFO - 'USER': 'cltbld', 02:31:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:46 INFO - '_': '/tools/buildbot/bin/python'} 02:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 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)) 02:31:46 INFO - Cleaning up... 02:31:46 INFO - Return code: 0 02:31:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f433b926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', '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 02:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:31:46 INFO - Using env: {'DISPLAY': ':0', 02:31:46 INFO - 'HOME': '/home/cltbld', 02:31:46 INFO - 'LANG': 'en_US.UTF-8', 02:31:46 INFO - 'LANGUAGE': 'en_US:en', 02:31:46 INFO - 'LOGNAME': 'cltbld', 02:31:46 INFO - 'MAIL': '/var/mail/cltbld', 02:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:46 INFO - 'MOZ_NO_REMOTE': '1', 02:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:46 INFO - 'NO_EM_RESTART': '1', 02:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:46 INFO - 'PWD': '/builds/slave/test', 02:31:46 INFO - 'SHELL': '/bin/bash', 02:31:46 INFO - 'SHLVL': '1', 02:31:46 INFO - 'TERM': 'linux', 02:31:46 INFO - 'TMOUT': '86400', 02:31:46 INFO - 'USER': 'cltbld', 02:31:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:46 INFO - '_': '/tools/buildbot/bin/python'} 02:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:31:46 INFO - Cleaning up... 02:31:46 INFO - Return code: 0 02:31:46 INFO - Running post-action listener: _resource_record_post_action 02:31:46 INFO - Running post-action listener: _start_resource_monitoring 02:31:46 INFO - Starting resource monitoring. 02:31:46 INFO - [mozharness: 2017-01-05 10:31:46.708119Z] Finished create-virtualenv step (success) 02:31:46 INFO - [mozharness: 2017-01-05 10:31:46.708623Z] Running install step. 02:31:46 INFO - Running pre-action listener: _resource_record_pre_action 02:31:46 INFO - Running main action method: install 02:31:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:46 INFO - Reading from file tmpfile_stdout 02:31:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:31:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:31:46 INFO - Reading from file tmpfile_stdout 02:31:46 INFO - Output received: 02:31:46 INFO - Usage: mozinstall [options] installer 02:31:46 INFO - Options: 02:31:46 INFO - -h, --help show this help message and exit 02:31:46 INFO - -d DEST, --destination=DEST 02:31:46 INFO - Directory to install application into. [default: 02:31:46 INFO - "/builds/slave/test"] 02:31:46 INFO - --app=APP Application being installed. [default: firefox] 02:31:46 INFO - mkdir: /builds/slave/test/build/application 02:31:46 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'] 02:31:46 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 02:32:02 INFO - Reading from file tmpfile_stdout 02:32:02 INFO - Output received: 02:32:02 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:02 INFO - Running post-action listener: _resource_record_post_action 02:32:02 INFO - [mozharness: 2017-01-05 10:32:02.921191Z] Finished install step (success) 02:32:02 INFO - [mozharness: 2017-01-05 10:32:02.921433Z] Running run-tests step. 02:32:02 INFO - Running pre-action listener: _resource_record_pre_action 02:32:02 INFO - Running main action method: run_tests 02:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:02 INFO - Python 2.7.3 02:32:02 INFO - Return code: 0 02:32:02 INFO - grabbing minidump binary from tooltool 02:32:02 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')]} 02:32:02 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 0x1a6bf60>, '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 0x1a6cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:02 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 02:32:02 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 02:32:02 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 02:32:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:02 INFO - Return code: 0 02:32:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:32:03 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:32:03 INFO - Using env: {'DISPLAY': ':0', 02:32:03 INFO - 'HOME': '/home/cltbld', 02:32:03 INFO - 'LANG': 'en_US.UTF-8', 02:32:03 INFO - 'LANGUAGE': 'en_US:en', 02:32:03 INFO - 'LOGNAME': 'cltbld', 02:32:03 INFO - 'MAIL': '/var/mail/cltbld', 02:32:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:03 INFO - 'MOZ_NO_REMOTE': '1', 02:32:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:03 INFO - 'NO_EM_RESTART': '1', 02:32:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:03 INFO - 'PWD': '/builds/slave/test', 02:32:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:03 INFO - 'SHELL': '/bin/bash', 02:32:03 INFO - 'SHLVL': '1', 02:32:03 INFO - 'TERM': 'linux', 02:32:03 INFO - 'TMOUT': '86400', 02:32:03 INFO - 'USER': 'cltbld', 02:32:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148', 02:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:03 INFO - '_': '/tools/buildbot/bin/python'} 02:32:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:32:03 INFO - mozversion application_buildid: 20170105004018 02:32:03 INFO - mozversion application_changeset: 5af63cf90f2874f840c132461bff7f6130483362 02:32:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:32:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:03 INFO - mozversion application_name: Firefox 02:32:03 INFO - mozversion application_remotingname: firefox-dev 02:32:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:03 INFO - mozversion application_vendor: Mozilla 02:32:03 INFO - mozversion application_version: 52.0a2 02:32:03 INFO - mozversion platform_buildid: 20170105004018 02:32:03 INFO - mozversion platform_changeset: 5af63cf90f2874f840c132461bff7f6130483362 02:32:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:03 INFO - mozversion platform_version: 52.0a2 02:32:03 INFO - using testdate: 1483612323 02:32:03 INFO - actual date: 1483612323 02:32:03 INFO - starting webserver on 'localhost:33127' 02:32:03 INFO - SUITE-START | Running 2 tests 02:32:03 INFO - TEST-START | dromaeo_css 02:32:03 INFO - operating with platform_type : linux_ 02:32:03 INFO - Initialising browser for dromaeo_css test... 02:32:03 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9mrXj8/profile http://localhost:33127/getInfo.html) 02:32:08 INFO - PROCESS | 3574 | __metrics Screen width/height:1600/1200 02:32:08 INFO - PROCESS | 3574 | colorDepth:24 02:32:08 INFO - PROCESS | 3574 | Browser inner width/height: 1024/697 02:32:08 INFO - PROCESS | 3574 | __metrics 02:32:08 ERROR - PROCESS | 3574 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:32:09 INFO - TEST-INFO | 3574: exit 0 02:32:09 INFO - Browser initialized. 02:32:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:09 INFO - TEST-INFO | started process 3706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9mrXj8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:21 INFO - PROCESS | 3706 | RSS: Main: 152309760 02:32:21 INFO - PROCESS | 3706 | 02:35:21 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33127/tests/dromaeo/cssquery-ext.html) 02:35:23 INFO - PROCESS | 3706 | RSS: Main: 156483584 02:35:23 INFO - PROCESS | 3706 | 02:38:25 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-ext.html (next: http://localhost:33127/tests/dromaeo/cssquery-jquery.html) 02:38:26 INFO - PROCESS | 3706 | RSS: Main: 153161728 02:38:26 INFO - PROCESS | 3706 | 02:41:27 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33127/tests/dromaeo/cssquery-mootools.html) 02:41:28 INFO - PROCESS | 3706 | RSS: Main: 153911296 02:41:28 INFO - PROCESS | 3706 | 02:44:30 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33127/tests/dromaeo/cssquery-prototype.html) 02:44:30 INFO - PROCESS | 3706 | RSS: Main: 152211456 02:44:30 INFO - PROCESS | 3706 | 02:47:33 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33127/tests/dromaeo/cssquery-yui.html) 02:47:34 INFO - PROCESS | 3706 | RSS: Main: 154849280 02:47:34 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | Cycle 1(1): loaded http://localhost:33127/tests/dromaeo/cssquery-yui.html (next: http://localhost:33127/tests/dromaeo/cssquery-dojo.html) 02:50:36 INFO - PROCESS | 3706 | RSS: Main: 156168192 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | __start_tp_report 02:50:36 INFO - PROCESS | 3706 | _x_x_mozilla_page_load 02:50:36 INFO - PROCESS | 3706 | _x_x_mozilla_page_load_details 02:50:36 INFO - PROCESS | 3706 | |i|pagename|runs| 02:50:36 INFO - PROCESS | 3706 | |0;dojo.html;3278.40988622048;3286.737061035117;3292.5390445337657;3294.80231186129;3296.489044198149;5683.374828768832;5689.715514224288;5735.655860648364;5756.079027355624;5771.278590176234;5608.495235428821;5696.829095127153;5719.313682358123;5735.741891614877;5750.453706897838;5107.055194788957;5161.638685292031;5182.4299327073995;5210.505002024802;5229.215617657363;5234.057869583493;5241.8427447176455;5252.658577192489;5258.894822103555;5269.710165940891;5026.170681837492;5031.949680503203;5208.921866172011;5212.29633999409;5243.187305967562;5128.5640720538795;5129.487051294859;5163.406208286057;5165.7158856262895;5186.040582492214;5156.92264616031;5198.636095473318;5200.6879587224885;5262.815866430061;5267.499587539178;5538.723063846832;5737.827865164052;5752.338481074688;5811.709414529299;5821.214136091616;6041.667708276043;6043.637381757065;6048.848778780522;6069.848253793646;6081.726322315506;6109.725062372204;6140.17107690465;6149.538784591174;6171.043488259327;6180.165677633552;5614.578906582023;5659.094544872883;5663.546916246691;5743.856403589902;5752.28096487939;6181.567290289637;6268.780592679234;6270.686465676789;6276.497880169575;6292.937070629327;6010.729517171738;6015.187949626832;6030.849228769228;6049.364816694272;6060.2424696912885;5951.672658003851;6028.065649824284;6092.1775560299675;6101.725422356005;6111.388861113942;6003.8198854034445;6091.695415229221;6096.420840020191;6107.029699522994;6152.477039451607;6096.014717947461;6115.209918062534;6137.285055221507;6161.876762464725;6169.8457538561;4592.311153327028;4752.7623618818925;4754.881127971828;4756.476787553366;4760.928586071212;4094.467719196485;4171.770552619635;4185.832566697298;4235;4237.067845074079;5804.332501762351;5806.564507661942;5809.622374545641;5828.0966450200285;5836.678982655994;5834.824955251349;5893.351731309553;6150.384961503813;6167.753289868355;6170;5742.483176514133;5757.165211044459;5779.768809247667;5878.970605146947;5900.793472228452;5163.148080566664;5179;5215.739213039333;5220.660657057279;5227.424983251915;6264.185655864709;6309.905351419732;6310.810675679737;6318.304986451487;6323.114763932961;5890.793822216202;6026.789062382795;6126.050462178369;6177.62934223948;6178.7219575120125;6332.461740752087;6336.936630633634;6337.588056776479;6338.841528961629;6350.650714210763;6085.756569737161;6102.694865256631;6106.3588323227195;6121.265448146251;6125;5948.078047902409;6012.759489620541;6102.084687296941;6127.464420129145;6128.4790792783115;6062.211912451353;6072.05883088122;6072.514198863992;6096.0855871619615;6126.816195514141;6069.150318955438;6073.331933487401;6082.2701275847185;6086.360932102066;6092.238470191226;5656.095024796013;5746.224259725051;5763.596548241583;6000.729967151576;6021.668808215591;5959.404059594006;6001.4298641628975;6020.4280593343565;6059.878802424015;6084.33072362031;5849;5885;5885.588008839341;5895.764169433174;5921.526277897672 02:50:36 INFO - PROCESS | 3706 | |1;ext.html;625.3027873920579;634.9587276827008;646.4020780777779;656.5896314803251;689.0904006711137;39890.202195956066;44695.55304446955;44762;44954;45135.77432112839;44769.7761511192;45010.54989450105;45247.773761131146;45347.09305813882;45456;8852.114788521145;8949.686760963368;8974;8978.326625503081;8978.775530611721;8550;8566.271866891322;8634.870476942819;8643;8660.263877570414;8846.867296990518;8852.203301702877;8887.73336799897;8905.198532132106;8910.064443233465;8809.295256379506;8834.160754728291;8874.29005679544;8879.334049946248;8900.109989001114;8759.255463285628;8811;8820.691275805317;8830.823383532294;8831.514266715329;42318;42613.78693106546;42680;42691.786541067406;42738;3680.5399325084363;3899.473571067898;3970.8014599269923;4158.147579746175;4325.891852703676;33637.495437568454;33685.83157084223;33690.32619347624;33728.32543349119;33822;4543.659225558096;4555.111753208126;4560.703554268962;4574.634029277683;4683.7892294846815;350140;353426;353489;354008;354649;62357.376426235154;62481.68759156266;62699.68650156811;62737;63270.36729632737;40002;40944.795276023426;41032.58967410288;43357;43569.12861742747;15781.526554203392;15836.129012904401;15869.761953570705;15901.681966360607;15927.920360398124;13772.449102036007;13833.170009799444;13849.376778045013;13945.302734863217;14004.08973416745;9421.717348479557;9651.71044868655;9675.661351852652;9844.9015509844;21005.36983890486;7314.597697126709;7416;7724;7747;7752.922470775333;1062.7927554127025;1066.3069005146563;1070.6413351527326;1092.9289596176222;1098.9394536216598;32474;32965.34069318648;32999.67000329966;33008.3398332032;33315.66684333126;1137.323292640894;1159.918805683594;1198.1852340408432;1207.1791181996327;1246.0716766009382;16663.416780412626;17259.654806904044;17717.911410443125;17935.820641793416;17987.280508779502;483805;485944;489041;493175;495739;61344.38655613476;61767.382326176164;62001.37998619956;62200;62496;1444.2634256529245;1445.6024593236943;1454;1454.403694485256;1499.572621802781;32299.51550726788;34130.65869341275;34724.82637586796;34782;34862.65137348594;54547.72726136344;54574;54942.725286373316;54986;55211;462468;462600;464139;464711;466875;30420.087397378113;31164.065078047694;31190.688093119687;31204.843975779975;31281.530777038817;40879;48327;49300.75349623229;52912.20631690605;52949.735251323495;41258.793706031276;41565.792171040164;42693.505727299394;43056;43818.780906095264;43243.35134972915;43530.34704479372;43592.12815743604;44129.55870441254;44327.33508997432;43488.56511434845;43794.781026094664;43924;44216.77891610521;44298.55701442944;35231.47152792761;37012.259754805295;37772.43341349827;38114;38136.618633813305;28873.133805985854;28974;29201;29389.853050735466;29452.852735736185 02:50:36 INFO - PROCESS | 3706 | |2;jquery.html;420.15339091730186;433.3175248982852;435.50135095315846;436.2692490079117;439.45288116295217;18660.626787464244;19323.613527729456;20116;20339.983000849934;20463.693044604322;18156;19823.801761982377;20264;20272;20434.284800032;5616.213730077782;5810.796622118227;5836.5914385993;5887.4406931341455;5891;5740.569457290699;5743.569232307573;5809.796657117002;5856.9414305857035;5941.732622031997;6063.514918806485;6093.482054025413;6099.451049405553;6120.418560236771;6130.938690613104;5891;6003.099535069731;6004.489618382443;6036.9737144685505;6081.452669259766;5784.623999440065;5817;5826.854328641775;5838.503727183194;5868.530517558585;13257.801132983013;13271.203727776365;13402.865971340358;13572.321383930765;13601.115927464683;2380.523895220963;2442.853428794278;2523.5079159563893;2538.695356557225;2908.3601607646283;9935.552900119439;9964.25268104895;10126.088652021353;10187.134093602053;10263.589456421734;1849.824266694662;1972.5857569910336;2004.258424382973;2035.155410504639;2049.1700861151257;89401;89866.5506672469;89953.10046899578;90854.54572727095;91207.54396228043;11793.351365674971;11975.88024119765;12151.210171338835;12230.633081007583;12292.877071229352;17228.397006104977;17307.653846922993;17366.65266694659;17403.390881319094;17443.30226790914;8175.182481751777;8423.284020858173;8431.451955622864;8447.408681392366;8610.813998820477;7736.806579835549;7741.458097933203;7758.612069396508;7804.84390312202;7897;5013.849584512471;5152.149895267314;5185.662931909414;5189.091908915924;5346.866328341823;2153.2894144932447;2177.54271602962;2192.9122835086737;2207.5253820428684;2245.360072379364;883.9248663863643;945.9574319155516;1040.9167266618804;1118.1893127482672;1126.3129491010477;20003.799962000485;20334.389968300973;20484.18063277482;20499;20729.45246331849;1017.8982101789762;1048.916086713061;1067.1676092647747;1116.0792346314324;1122.354646078508;11067.335959842436;11242.100631949424;11482.48328825205;11532.769344613062;11534.653960381202;434074;436875;446547;447910;449045;92871;95179.04820951702;95984.52007739917;96540.51729741307;99894.5005274969;1013.8225810483136;1051.6476980211562;1083.5990683447017;1095.0691911875;1100.5982816272003;17508.299668013136;17722.202500887233;17961.281548737905;18040.18819153115;18357.632847343244;42397;42421.575784242996;42634;42762.57237427586;43251.78374108109;55779;59753.701231493564;60672.696636516535;60955.69522152361;61651.691741541006;8252.958735206286;8435.072142064246;8494;8733.65065397377;8853;11943.223690460092;12813.295268760308;12958.935205323913;13025.869741302466;13517.932410337886;6058.0610005449225;9402.905970940477;9715.902840971783;11349.602763903224;11772.764544709229;11458.255213411101;11557.47991340375;11680.182387232811;12098.939505302416;12424.689382765504;12037.217580857216;12159.939200303941;12165.635030949086;12301.815472768094;12387.442565084773;8435.83128337442;8508.27679647237;8558.957205213934;8601.182887625666;8837.337199709918;11592.710182245512;11661.183717139718;11752.177347585586;11768.058555315725;11803.645890623295 02:50:36 INFO - PROCESS | 3706 | |3;mootools.html;1501.4894935721857;1530.525537083504;1669.2238109279183;1789.758382618346;1818.2999545175103;7969.840603187933;8166.060902996142;8499.787505312363;9028.097190280976;9051.502167380791;8487.44831585948;8702.303815694746;8708;8908.51003194824;9003.549822508881;2455.116158183057;2458.0782206672498;2475.517274131545;2488.1664642344745;2490.1906880263896;2435.622478515833;2500.2124330835727;2522.2055052658447;2525.217182673368;2525.217182673377;2446.6085426331792;2448.045262347686;2449.80401567875;2459.090136649433;2462.655228268035;2382.725986511556;2406.302172370011;2407.9398015049587;2413.2036427978815;2418.0207016158483;2338.824588155895;2366.2782851230368;2399.5800734871327;2401.795847352977;2403.182917807936;9005.099490050943;9014.549272536347;9026.729198124001;9099.454032757989;9099.818003639957;5372.758225879845;5447.618666693333;5487.149491828773;5488.725563721838;5494.230807686927;3516.40221162403;3587.264610754789;3594.7663401879054;3596.28074385124;3663.285659296438;1189.4766302826815;1200.3818033712646;1220.78025955328;1241.8323526324011;1253.8181963615225;12693.555725549653;12694.174878632952;12700.364981750876;12760.80858787119;12772.105952583323;4657.127624317351;4758.286257061399;4779.402574678165;4865.635077369211;4870.245112007645;10528.263021588415;10539.94730026345;10553.366797992145;10564.947175264075;10570.735731606772;5499.532539734168;5509.090999984957;5541.085720856095;5561.6663000220115;5564.610477266552;4961.280614310905;5017.297578339036;5062.417821950523;5090.541851233407;5209.895802083937;4036.8183431745056;4047.615476529725;4097.8975525612095;4128.3601041838565;4130.483689538808;1231.759806837676;1253.4359538207843;1259.250745806262;1264.987350126487;1266.639007882749;997.2271489595477;1021.5862575656871;1059.2638116509106;1065.105311538296;1077.5151181968147;6195.628262304276;6306.306306306303;6348.936595606354;6367.885620016571;6381.872362552723;487.4199702354187;1038.99480502597;1072.0726571515738;1077.1221454514703;1125.5329038448951;4228.090960443458;4263.8081286342185;4315.331123675835;4374.606285434326;4486.371907932892;11033.448327583588;11319.037881779976;11370.31778093317;11398.259113157617;11445;11038.724031899266;11087.445627718582;11192.216544841784;11398.94300528492;11407.144464165054;8363.95818020906;8453.070162282143;8498.915010849936;8666.176713212235;8677.6528938843;6064.969675151596;6105.236845394325;6155.84610384744;6239.719212635533;6262.40507151838;10221.540030698488;10321.380717156995;10359.430231337348;10399.740006499898;10404.58381664725;10187.43969081678;10249.897501024894;10461.738456538647;10592.841107383549;10593.470326483799;7514.661840217094;7541.396688264816;7698;7703.191164927826;7714.575698336421;8795.868061979203;8806.20744133031;8832.779180520538;8848.646054157762;8851.380403371702;7924.366050715814;7938.483998540077;8004.319632831041;8031.437799353989;8084.312833408991;7852;7880.645370958206;7927.920720792718;7935.365170786208;7977.880331794911;7354.1910389856;7358.227386124594;7376.077990251219;7397.96301018513;7428.182899881117;5332.253484512094;5347.732613369394;5418.008105681431;5434.130539113723;5508.063629182969;5293.100172970528;5341.092014357491;5376.059189641719;5455.18172274162;5459.099248623933 02:50:36 INFO - PROCESS | 3706 | |4;prototype.html;341.34972876669946;352.09160366255065;352.2743149112828;353.409805624607;354.41344574728834;5716.371199168093;5719.828405147842;5773.913391299128;5776.971115144418;5804.854878628036;5606;5625.76233228689;5628.183913332565;5640.210370548127;5653;3967.4048892666187;4231.06916478375;4384.539623339551;4443.733375997434;4447.1995040892625;4447.466304043519;4447.955520444786;4463.196624607569;4471.374007638917;4479.2609219478745;4458.9331160032625;4460.130274596455;4460.420145381112;4469.748470428285;4472.843450479234;4191.371294305848;4288.48538175421;4330.696851220416;4455.554444555551;4460.8438704645505;3836;3840.7311488195837;3842.846286148551;3848.730588858781;3854.498915141042;5500;5509.1268968550485;5541.362743284533;5555.50000499957;5555.833325000256;4897.8775530611665;4981.12830254704;4985.925211121836;5004.574611158056;5044.259730393009;5892.175095486636;5906.527477801808;5940.881182376372;5941.702914854283;5944.762209511614;4166.562510936338;4175.603317684815;4240.448741663595;4241.1941731071;4255.425517555122;6095.238095238095;6114.510839132903;6136.96931515344;6171.611387437835;6221.377862213788;4297.59172878576;4305.16049370376;4309.439772829513;4311.1808756336195;4312.568743125662;4427.136708341843;4433.667474939392;4436.889077773081;4440.578145076277;4440.977795111004;4735.431748190239;4937.802487900443;5004.2493625956395;5055.443901170868;5064.316317297192;5947.762089516371;5950.226470558886;5960.7019649017375;5991.580589358703;6006.189164462829;1468.3612628506635;1472.5876754508754;1475.2844870237925;1479.8742106921031;1480.3116550803927;983.3362480325751;1019.6584144311738;1027.306568066552;1033.963811266617;1043.1602559939322;5500.724963751796;5539.723013849372;5543.556515478752;5573.4394369575775;5583.096789669349;5887;5927.2590926134235;5941.465268125803;5942.276739745512;5968.970550013017;5415.593830462731;5524.281843360337;5725.914111288334;5797.4782269595935;5801.593888427769;3186.1556687477837;3197.2965947491516;3199.9760076775674;3208.9358212836078;3214.100051985448;6035.130308472133;6050;6096.847578810565;6182.381761823782;6207.379262073847;6039.365866583946;6107.8473038173515;6115.847103822351;6118.776244750979;6139.631622102688;6249.937500625027;6270.843228919313;6279.529035322278;6280.995040793542;6282.340354262737;6134;6160.969195153995;6166.506679465721;6168.167297414791;6192.164057852313;6005.489533389711;6041.486473649789;6082.878342433038;6108.35862234459;6120.1125836752535;6257.4681152102585;6274.14912600793;6279.277883043508;6294.590851594632;6296;4263.189993901149;4369.628581570602;4399.472063352418;4415.977920110379;4416.514183439884;6156;6159.322474527708;6162.722677479614;6171.876562468815;6176.876462470816;5974.731137098754;6008.669523176267;6028.517718582415;6063.757449701962;6065.604910870613;5811.56413268998;5957.6127551709;6004.309504407049;6006.279246490449;6021.367756385516;5942.58401911862;5958.970205148947;5968.16445697594;5975.850603734942;6006.249218847644;5923.585349025527;5979.162917191684;6007.699615019319;6078.331383547895;6084.269887613515;5817.9127313091185;5848.94718950593;5849.034909239927;5868.794592189423;5934.762609495572 02:50:36 INFO - PROCESS | 3706 | |5;yui.html;804.16768644453;806.620888182554;828.9295409890159;835.3233880556749;896.730980705788;15642.765358519631;16035.438759643415;16141.192940352994;16141.515754527354;16296.103714295723;14675.77986330206;14818.333175007123;14821.333040013198;14841.480548180816;14842.406303747865;857.7255278310943;868.769776009358;872.6640243506264;872.9829748343172;873.10506730601;855.4183155454289;861.0571424290392;869.2915274051659;870.0299166429418;873.0789017586444;901.5086777706133;904.159132007233;908.7682640926588;909.4406939732083;914.7210100919217;895.6909866096187;897.6364572348144;898.2454738020061;901.4320977783987;905.9094090590954;666.3503084492629;666.7799626123368;671.684308375063;671.9899201511981;673.0005941177347;13352;13421.127626704232;13458.730825383536;13465.865341346656;13499.86500134996;12844;13084.345782710827;13168.407421665952;13245.536406225832;13273.601791946257;11267.492962816694;11324.50594457037;11331.773364532663;11333;11449.771004579945;3790.33669107905;3818.1218319786326;3876;3910.6284902934176;3918.040080180374;56343.71828140833;57756.71121644407;59752.70123649397;63800.36199638037;64485.355146448404;11229;11327.660170194908;11460.083193344512;11488;11610.941945290388;20710.275140370013;20803.68794468084;20806.687899681518;20826.583468330547;20981.055852486676;8809.383343165917;8907.287417006624;8918.598663060178;9123.81752364949;9344.626214951462;4977.452480227172;4985.501449854985;5035.320231768665;5064.088464076428;5126.5898728101665;3550.0592343029116;3677.963220367762;3692.150805314739;3702.833372498244;3711.183539621279;668.2749217099405;668.5520701130255;677.9118714567173;688.9276625954303;691.8512519808165;637.6014990630856;659.8218481010197;676.8307923019245;741.2180149941755;742.9294217049371;9257.398269112486;9450.669226577036;9676.225901927828;9679.854802177973;9866.062724041205;641.5637366590763;745.5861996591943;757.0914902117481;777.3780975219802;785.3167744062702;4391.714538554984;4404.493483249467;4620.932155272867;4717.787699553528;4751.263554149113;89457;90292;91643;94239.52880235555;94732;64911.35088649053;67374.66312668503;80825.59587202026;82345;84552.57723711342;66581.66709166423;69258;69280;70129.29870701431;70262;8584.270337021424;8826.5586720665;9012.233960113464;9309.348345615741;9317.767055823659;36046.45930310995;41413.378799317434;44969;47049.76475117602;47140.7642961783;61767;63917.68041159764;66055.34861628305;66404.33595663981;67365;11806.586769463027;11911.880881191077;11945.641630751092;12060.396980151132;12539.310337931502;13434.529791457253;13904.096233744775;13965.930170349084;13966.930165349107;13971.30143492801;12126.757464850478;12343.444544995677;12386.31875246834;12698.809517857424;13009.284489353176;11809.409529523318;12067.456964436446;12788.552400666304;12789.42447589842;12822.23066616006;12852.55016074433;12853.614391568268;12974.35128243603;13093.476260949456;13612.65968350799;10495.41795604014;10619.893801061891;10815.35107893529;10963.56145754161;10983.340999540053;10749.516271767945;11009.394483303175;11039.369921340334;11040.779184416428;11418.0865530759 02:50:36 INFO - PROCESS | 3706 | __end_tp_report 02:50:36 INFO - PROCESS | 3706 | __start_cc_report 02:50:36 INFO - PROCESS | 3706 | _x_x_mozilla_cycle_collect,316 02:50:36 INFO - PROCESS | 3706 | __end_cc_report 02:50:36 INFO - PROCESS | 3706 | __startTimestamp1483613436543__endTimestamp 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | ------- Summary: start ------- 02:50:36 INFO - PROCESS | 3706 | Number of tests: 6 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#0] dojo.html Cycles:165 Average:5680.64 Median:5893.35 stddev:647.79 (11.0%) stddev-sans-first:621.76 02:50:36 INFO - PROCESS | 3706 | Values: 3278.4 3286.7 3292.5 3294.8 3296.5 5683.4 5689.7 5735.7 5756.1 5771.3 5608.5 5696.8 5719.3 5735.7 5750.5 5107.1 5161.6 5182.4 5210.5 5229.2 5234.1 5241.8 5252.7 5258.9 5269.7 5026.2 5031.9 5208.9 5212.3 5243.2 5128.6 5129.5 5163.4 5165.7 5186.0 5156.9 5198.6 5200.7 5262.8 5267.5 5538.7 5737.8 5752.3 5811.7 5821.2 6041.7 6043.6 6048.8 6069.8 6081.7 6109.7 6140.2 6149.5 6171.0 6180.2 5614.6 5659.1 5663.5 5743.9 5752.3 6181.6 6268.8 6270.7 6276.5 6292.9 6010.7 6015.2 6030.8 6049.4 6060.2 5951.7 6028.1 6092.2 6101.7 6111.4 6003.8 6091.7 6096.4 6107.0 6152.5 6096.0 6115.2 6137.3 6161.9 6169.8 4592.3 4752.8 4754.9 4756.5 4760.9 4094.5 4171.8 4185.8 4235.0 4237.1 5804.3 5806.6 5809.6 5828.1 5836.7 5834.8 5893.4 6150.4 6167.8 6170.0 5742.5 5757.2 5779.8 5879.0 5900.8 5163.1 5179.0 5215.7 5220.7 5227.4 6264.2 6309.9 6310.8 6318.3 6323.1 5890.8 6026.8 6126.1 6177.6 6178.7 6332.5 6336.9 6337.6 6338.8 6350.7 6085.8 6102.7 6106.4 6121.3 6125.0 5948.1 6012.8 6102.1 6127.5 6128.5 6062.2 6072.1 6072.5 6096.1 6126.8 6069.2 6073.3 6082.3 6086.4 6092.2 5656.1 5746.2 5763.6 6000.7 6021.7 5959.4 6001.4 6020.4 6059.9 6084.3 5849.0 5885.0 5885.6 5895.8 5921.5 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#1] ext.html Cycles:180 Average:60028.42 Median:43693.45 stddev:116330.92 (266.2%) stddev-sans-first:116571.76 02:50:36 INFO - PROCESS | 3706 | Values: 625.3 635.0 646.4 656.6 689.1 39890.2 44695.6 44762.0 44954.0 45135.8 44769.8 45010.5 45247.8 45347.1 45456.0 8852.1 8949.7 8974.0 8978.3 8978.8 8550.0 8566.3 8634.9 8643.0 8660.3 8846.9 8852.2 8887.7 8905.2 8910.1 8809.3 8834.2 8874.3 8879.3 8900.1 8759.3 8811.0 8820.7 8830.8 8831.5 42318.0 42613.8 42680.0 42691.8 42738.0 3680.5 3899.5 3970.8 4158.1 4325.9 33637.5 33685.8 33690.3 33728.3 33822.0 4543.7 4555.1 4560.7 4574.6 4683.8 350140.0 353426.0 353489.0 354008.0 354649.0 62357.4 62481.7 62699.7 62737.0 63270.4 40002.0 40944.8 41032.6 43357.0 43569.1 15781.5 15836.1 15869.8 15901.7 15927.9 13772.4 13833.2 13849.4 13945.3 14004.1 9421.7 9651.7 9675.7 9844.9 21005.4 7314.6 7416.0 7724.0 7747.0 7752.9 1062.8 1066.3 1070.6 1092.9 1098.9 32474.0 32965.3 32999.7 33008.3 33315.7 1137.3 1159.9 1198.2 1207.2 1246.1 16663.4 17259.7 17717.9 17935.8 17987.3 483805.0 485944.0 489041.0 493175.0 495739.0 61344.4 61767.4 62001.4 62200.0 62496.0 1444.3 1445.6 1454.0 1454.4 1499.6 32299.5 34130.7 34724.8 34782.0 34862.7 54547.7 54574.0 54942.7 54986.0 55211.0 462468.0 462600.0 464139.0 464711.0 466875.0 30420.1 31164.1 31190.7 31204.8 31281.5 40879.0 48327.0 49300.8 52912.2 52949.7 41258.8 41565.8 42693.5 43056.0 43818.8 43243.4 43530.3 43592.1 44129.6 44327.3 43488.6 43794.8 43924.0 44216.8 44298.6 35231.5 37012.3 37772.4 38114.0 38136.6 28873.1 28974.0 29201.0 29389.9 29452.9 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#2] jquery.html Cycles:180 Average:28072.88 Median:2531.10 stddev:73646.53 (2909.7%) stddev-sans-first:73823.86 02:50:36 INFO - PROCESS | 3706 | Values: 420.2 433.3 435.5 436.3 439.5 18660.6 19323.6 20116.0 20340.0 20463.7 18156.0 19823.8 20264.0 20272.0 20434.3 5616.2 5810.8 5836.6 5887.4 5891.0 5740.6 5743.6 5809.8 5856.9 5941.7 6063.5 6093.5 6099.5 6120.4 6130.9 5891.0 6003.1 6004.5 6037.0 6081.5 5784.6 5817.0 5826.9 5838.5 5868.5 13257.8 13271.2 13402.9 13572.3 13601.1 2380.5 2442.9 2523.5 2538.7 2908.4 9935.6 9964.3 10126.1 10187.1 10263.6 1849.8 1972.6 2004.3 2035.2 2049.2 89401.0 89866.6 89953.1 90854.5 91207.5 11793.4 11975.9 12151.2 12230.6 12292.9 17228.4 17307.7 17366.7 17403.4 17443.3 8175.2 8423.3 8431.5 8447.4 8610.8 7736.8 7741.5 7758.6 7804.8 7897.0 5013.8 5152.1 5185.7 5189.1 5346.9 2153.3 2177.5 2192.9 2207.5 2245.4 883.9 946.0 1040.9 1118.2 1126.3 20003.8 20334.4 20484.2 20499.0 20729.5 1017.9 1048.9 1067.2 1116.1 1122.4 11067.3 11242.1 11482.5 11532.8 11534.7 434074.0 436875.0 446547.0 447910.0 449045.0 92871.0 95179.0 95984.5 96540.5 99894.5 1013.8 1051.6 1083.6 1095.1 1100.6 17508.3 17722.2 17961.3 18040.2 18357.6 42397.0 42421.6 42634.0 42762.6 43251.8 55779.0 59753.7 60672.7 60955.7 61651.7 8253.0 8435.1 8494.0 8733.7 8853.0 11943.2 12813.3 12958.9 13025.9 13517.9 6058.1 9402.9 9715.9 11349.6 11772.8 11458.3 11557.5 11680.2 12098.9 12424.7 12037.2 12159.9 12165.6 12301.8 12387.4 8435.8 8508.3 8559.0 8601.2 8837.3 11592.7 11661.2 11752.2 11768.1 11803.6 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#3] mootools.html Cycles:180 Average:5992.01 Median:4344.97 stddev:3357.82 (77.3%) stddev-sans-first:3350.28 02:50:36 INFO - PROCESS | 3706 | Values: 1501.5 1530.5 1669.2 1789.8 1818.3 7969.8 8166.1 8499.8 9028.1 9051.5 8487.4 8702.3 8708.0 8908.5 9003.5 2455.1 2458.1 2475.5 2488.2 2490.2 2435.6 2500.2 2522.2 2525.2 2525.2 2446.6 2448.0 2449.8 2459.1 2462.7 2382.7 2406.3 2407.9 2413.2 2418.0 2338.8 2366.3 2399.6 2401.8 2403.2 9005.1 9014.5 9026.7 9099.5 9099.8 5372.8 5447.6 5487.1 5488.7 5494.2 3516.4 3587.3 3594.8 3596.3 3663.3 1189.5 1200.4 1220.8 1241.8 1253.8 12693.6 12694.2 12700.4 12760.8 12772.1 4657.1 4758.3 4779.4 4865.6 4870.2 10528.3 10539.9 10553.4 10564.9 10570.7 5499.5 5509.1 5541.1 5561.7 5564.6 4961.3 5017.3 5062.4 5090.5 5209.9 4036.8 4047.6 4097.9 4128.4 4130.5 1231.8 1253.4 1259.3 1265.0 1266.6 997.2 1021.6 1059.3 1065.1 1077.5 6195.6 6306.3 6348.9 6367.9 6381.9 487.4 1039.0 1072.1 1077.1 1125.5 4228.1 4263.8 4315.3 4374.6 4486.4 11033.4 11319.0 11370.3 11398.3 11445.0 11038.7 11087.4 11192.2 11398.9 11407.1 8364.0 8453.1 8498.9 8666.2 8677.7 6065.0 6105.2 6155.8 6239.7 6262.4 10221.5 10321.4 10359.4 10399.7 10404.6 10187.4 10249.9 10461.7 10592.8 10593.5 7514.7 7541.4 7698.0 7703.2 7714.6 8795.9 8806.2 8832.8 8848.6 8851.4 7924.4 7938.5 8004.3 8031.4 8084.3 7852.0 7880.6 7927.9 7935.4 7977.9 7354.2 7358.2 7376.1 7398.0 7428.2 5332.3 5347.7 5418.0 5434.1 5508.1 5293.1 5341.1 5376.1 5455.2 5459.1 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#4] prototype.html Cycles:180 Average:4995.68 Median:5684.69 stddev:1477.17 (26.0%) stddev-sans-first:1439.42 02:50:36 INFO - PROCESS | 3706 | Values: 341.3 352.1 352.3 353.4 354.4 5716.4 5719.8 5773.9 5777.0 5804.9 5606.0 5625.8 5628.2 5640.2 5653.0 3967.4 4231.1 4384.5 4443.7 4447.2 4447.5 4448.0 4463.2 4471.4 4479.3 4458.9 4460.1 4460.4 4469.7 4472.8 4191.4 4288.5 4330.7 4455.6 4460.8 3836.0 3840.7 3842.8 3848.7 3854.5 5500.0 5509.1 5541.4 5555.5 5555.8 4897.9 4981.1 4985.9 5004.6 5044.3 5892.2 5906.5 5940.9 5941.7 5944.8 4166.6 4175.6 4240.4 4241.2 4255.4 6095.2 6114.5 6137.0 6171.6 6221.4 4297.6 4305.2 4309.4 4311.2 4312.6 4427.1 4433.7 4436.9 4440.6 4441.0 4735.4 4937.8 5004.2 5055.4 5064.3 5947.8 5950.2 5960.7 5991.6 6006.2 1468.4 1472.6 1475.3 1479.9 1480.3 983.3 1019.7 1027.3 1034.0 1043.2 5500.7 5539.7 5543.6 5573.4 5583.1 5887.0 5927.3 5941.5 5942.3 5969.0 5415.6 5524.3 5725.9 5797.5 5801.6 3186.2 3197.3 3200.0 3208.9 3214.1 6035.1 6050.0 6096.8 6182.4 6207.4 6039.4 6107.8 6115.8 6118.8 6139.6 6249.9 6270.8 6279.5 6281.0 6282.3 6134.0 6161.0 6166.5 6168.2 6192.2 6005.5 6041.5 6082.9 6108.4 6120.1 6257.5 6274.1 6279.3 6294.6 6296.0 4263.2 4369.6 4399.5 4416.0 4416.5 6156.0 6159.3 6162.7 6171.9 6176.9 5974.7 6008.7 6028.5 6063.8 6065.6 5811.6 5957.6 6004.3 6006.3 6021.4 5942.6 5959.0 5968.2 5975.9 6006.2 5923.6 5979.2 6007.7 6078.3 6084.3 5817.9 5848.9 5849.0 5868.8 5934.8 02:50:36 INFO - PROCESS | 3706 | 02:50:36 INFO - PROCESS | 3706 | [#5] yui.html Cycles:180 Average:17909.12 Median:4981.48 stddev:23795.05 (477.7%) stddev-sans-first:23827.13 02:50:36 INFO - PROCESS | 3706 | Values: 804.2 806.6 828.9 835.3 896.7 15642.8 16035.4 16141.2 16141.5 16296.1 14675.8 14818.3 14821.3 14841.5 14842.4 857.7 868.8 872.7 873.0 873.1 855.4 861.1 869.3 870.0 873.1 901.5 904.2 908.8 909.4 914.7 895.7 897.6 898.2 901.4 905.9 666.4 666.8 671.7 672.0 673.0 13352.0 13421.1 13458.7 13465.9 13499.9 12844.0 13084.3 13168.4 13245.5 13273.6 11267.5 11324.5 11331.8 11333.0 11449.8 3790.3 3818.1 3876.0 3910.6 3918.0 56343.7 57756.7 59752.7 63800.4 64485.4 11229.0 11327.7 11460.1 11488.0 11610.9 20710.3 20803.7 20806.7 20826.6 20981.1 8809.4 8907.3 8918.6 9123.8 9344.6 4977.5 4985.5 5035.3 5064.1 5126.6 3550.1 3678.0 3692.2 3702.8 3711.2 668.3 668.6 677.9 688.9 691.9 637.6 659.8 676.8 741.2 742.9 9257.4 9450.7 9676.2 9679.9 9866.1 641.6 745.6 757.1 777.4 785.3 4391.7 4404.5 4620.9 4717.8 4751.3 89457.0 90292.0 91643.0 94239.5 94732.0 64911.4 67374.7 80825.6 82345.0 84552.6 66581.7 69258.0 69280.0 70129.3 70262.0 8584.3 8826.6 9012.2 9309.3 9317.8 36046.5 41413.4 44969.0 47049.8 47140.8 61767.0 63917.7 66055.3 66404.3 67365.0 11806.6 11911.9 11945.6 12060.4 12539.3 13434.5 13904.1 13965.9 13966.9 13971.3 12126.8 12343.4 12386.3 12698.8 13009.3 11809.4 12067.5 12788.6 12789.4 12822.2 12852.6 12853.6 12974.4 13093.5 13612.7 10495.4 10619.9 10815.4 10963.6 10983.3 10749.5 11009.4 11039.4 11040.8 11418.1 02:50:36 INFO - PROCESS | 3706 | -------- Summary: end -------- 02:50:36 INFO - PROCESS | 3706 | 02:50:37 INFO - TEST-INFO | 3706: exit 0 02:50:37 INFO - TEST-OK | dromaeo_css | took 1114155ms 02:50:37 INFO - TEST-START | kraken 02:50:37 INFO - operating with platform_type : linux_ 02:50:37 INFO - Initialising browser for kraken test... 02:50:37 INFO - TEST-INFO | started process 4077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprRy5qf/profile http://localhost:33127/getInfo.html) 02:50:42 INFO - PROCESS | 4077 | __metrics Screen width/height:1600/1200 02:50:42 INFO - PROCESS | 4077 | colorDepth:24 02:50:42 INFO - PROCESS | 4077 | Browser inner width/height: 1024/697 02:50:42 INFO - PROCESS | 4077 | __metrics 02:50:43 ERROR - PROCESS | 4077 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:50:43 INFO - TEST-INFO | 4077: exit 0 02:50:43 INFO - Browser initialized. 02:50:43 INFO - Running cycle 1/1 for kraken test... 02:50:43 INFO - TEST-INFO | started process 4210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprRy5qf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:55 INFO - PROCESS | 4210 | RSS: Main: 152469504 02:50:55 INFO - PROCESS | 4210 | 02:50:58 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33127/tests/kraken/driver.html?testName=audio-beat-detection) 02:50:59 INFO - PROCESS | 4210 | RSS: Main: 157519872 02:50:59 INFO - PROCESS | 4210 | 02:51:01 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33127/tests/kraken/driver.html?testName=audio-dft) 02:51:02 INFO - PROCESS | 4210 | RSS: Main: 155389952 02:51:02 INFO - PROCESS | 4210 | 02:51:05 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33127/tests/kraken/driver.html?testName=audio-fft) 02:51:05 INFO - PROCESS | 4210 | RSS: Main: 155512832 02:51:05 INFO - PROCESS | 4210 | 02:51:07 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33127/tests/kraken/driver.html?testName=audio-oscillator) 02:51:08 INFO - PROCESS | 4210 | RSS: Main: 156094464 02:51:08 INFO - PROCESS | 4210 | 02:51:10 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:11 INFO - PROCESS | 4210 | RSS: Main: 155467776 02:51:11 INFO - PROCESS | 4210 | 02:51:14 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33127/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:14 INFO - PROCESS | 4210 | RSS: Main: 158281728 02:51:14 INFO - PROCESS | 4210 | 02:51:18 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33127/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:18 INFO - PROCESS | 4210 | RSS: Main: 158314496 02:51:18 INFO - PROCESS | 4210 | 02:51:21 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33127/tests/kraken/driver.html?testName=json-parse-financial) 02:51:22 INFO - PROCESS | 4210 | RSS: Main: 158322688 02:51:22 INFO - PROCESS | 4210 | 02:51:23 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:24 INFO - PROCESS | 4210 | RSS: Main: 157560832 02:51:24 INFO - PROCESS | 4210 | 02:51:26 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:26 INFO - PROCESS | 4210 | RSS: Main: 157876224 02:51:26 INFO - PROCESS | 4210 | 02:51:28 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:51:29 INFO - PROCESS | 4210 | RSS: Main: 158060544 02:51:29 INFO - PROCESS | 4210 | 02:51:31 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:51:32 INFO - PROCESS | 4210 | RSS: Main: 157851648 02:51:32 INFO - PROCESS | 4210 | 02:51:35 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:51:35 INFO - PROCESS | 4210 | RSS: Main: 158121984 02:51:35 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | Cycle 1(1): loaded http://localhost:33127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33127/tests/kraken/driver.html?testName=ai-astar) 02:51:37 INFO - PROCESS | 4210 | RSS: Main: 160133120 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | __start_tp_report 02:51:37 INFO - PROCESS | 4210 | _x_x_mozilla_page_load 02:51:37 INFO - PROCESS | 4210 | _x_x_mozilla_page_load_details 02:51:37 INFO - PROCESS | 4210 | |i|pagename|runs| 02:51:37 INFO - PROCESS | 4210 | |0;ai-astar;101;112;113;114;111;113;111;113;111;112 02:51:37 INFO - PROCESS | 4210 | |1;audio-beat-detection;154;124;119;162;126;118;121;119;147;122 02:51:37 INFO - PROCESS | 4210 | |2;audio-dft;162;160;163;163;161;163;162;162;161;162 02:51:37 INFO - PROCESS | 4210 | |3;audio-fft;76;74;74;110;75;76;75;75;101;75 02:51:37 INFO - PROCESS | 4210 | |4;audio-oscillator;83;83;111;83;83;82;98;81;81;120 02:51:37 INFO - PROCESS | 4210 | |5;imaging-gaussian-blur;118;118;118;117;117;118;118;118;118;118 02:51:37 INFO - PROCESS | 4210 | |6;imaging-darkroom;146;148;146;147;147;148;148;147;147;148 02:51:37 INFO - PROCESS | 4210 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;86;85 02:51:37 INFO - PROCESS | 4210 | |8;json-parse-financial;51;51;52;51;51;52;54;51;52;55 02:51:37 INFO - PROCESS | 4210 | |9;json-stringify-tinderbox;60;60;60;59;60;60;60;60;59;60 02:51:37 INFO - PROCESS | 4210 | |10;stanford-crypto-aes;75;74;75;75;79;75;75;75;74;79 02:51:37 INFO - PROCESS | 4210 | |11;stanford-crypto-ccm;123;130;124;122;121;121;130;131;166;131 02:51:37 INFO - PROCESS | 4210 | |12;stanford-crypto-pbkdf2;154;156;156;153;158;154;156;154;154;153 02:51:37 INFO - PROCESS | 4210 | |13;stanford-crypto-sha256-iterative;63;62;63;62;64;62;62;62;62;64 02:51:37 INFO - PROCESS | 4210 | __end_tp_report 02:51:37 INFO - PROCESS | 4210 | __start_cc_report 02:51:37 INFO - PROCESS | 4210 | _x_x_mozilla_cycle_collect,831 02:51:37 INFO - PROCESS | 4210 | __end_cc_report 02:51:37 INFO - PROCESS | 4210 | __startTimestamp1483613497736__endTimestamp 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | ------- Summary: start ------- 02:51:37 INFO - PROCESS | 4210 | Number of tests: 14 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.70 (3.3%) stddev-sans-first:1.09 02:51:37 INFO - PROCESS | 4210 | Values: 101.0 112.0 113.0 114.0 111.0 113.0 111.0 113.0 111.0 112.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:125.00 stddev:16.52 (13.2%) stddev-sans-first:15.33 02:51:37 INFO - PROCESS | 4210 | Values: 154.0 124.0 119.0 162.0 126.0 118.0 121.0 119.0 147.0 122.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 02:51:37 INFO - PROCESS | 4210 | Values: 162.0 160.0 163.0 163.0 161.0 163.0 162.0 162.0 161.0 162.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.05 (17.4%) stddev-sans-first:13.71 02:51:37 INFO - PROCESS | 4210 | Values: 76.0 74.0 74.0 110.0 75.0 76.0 75.0 75.0 101.0 75.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:14.24 (17.2%) stddev-sans-first:14.84 02:51:37 INFO - PROCESS | 4210 | Values: 83.0 83.0 111.0 83.0 83.0 82.0 98.0 81.0 81.0 120.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:51:37 INFO - PROCESS | 4210 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:51:37 INFO - PROCESS | 4210 | Values: 146.0 148.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 02:51:37 INFO - PROCESS | 4210 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.41 (2.7%) stddev-sans-first:1.45 02:51:37 INFO - PROCESS | 4210 | Values: 51.0 51.0 52.0 51.0 51.0 52.0 54.0 51.0 52.0 55.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:51:37 INFO - PROCESS | 4210 | Values: 60.0 60.0 60.0 59.0 60.0 60.0 60.0 60.0 59.0 60.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:1.84 (2.5%) stddev-sans-first:1.94 02:51:37 INFO - PROCESS | 4210 | Values: 75.0 74.0 75.0 75.0 79.0 75.0 75.0 75.0 74.0 79.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:130.00 stddev:13.37 (10.3%) stddev-sans-first:13.95 02:51:37 INFO - PROCESS | 4210 | Values: 123.0 130.0 124.0 122.0 121.0 121.0 130.0 131.0 166.0 131.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 02:51:37 INFO - PROCESS | 4210 | Values: 154.0 156.0 156.0 153.0 158.0 154.0 156.0 154.0 154.0 153.0 02:51:37 INFO - PROCESS | 4210 | 02:51:37 INFO - PROCESS | 4210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 02:51:37 INFO - PROCESS | 4210 | Values: 63.0 62.0 63.0 62.0 64.0 62.0 62.0 62.0 62.0 64.0 02:51:37 INFO - PROCESS | 4210 | -------- Summary: end -------- 02:51:37 INFO - PROCESS | 4210 | 02:51:38 INFO - TEST-INFO | 4210: exit 0 02:51:38 INFO - TEST-OK | kraken | took 61441ms 02:51:38 INFO - SUITE-END | took 1175s 02:51:38 INFO - Completed test suite (00:19:35) 02:51:38 INFO - javascript benchmark 02:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7450.6492685618305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.40988622048, 3286.737061035117, 3292.5390445337657, 3294.80231186129, 3296.489044198149, 5683.374828768832, 5689.715514224288, 5735.655860648364, 5756.079027355624, 5771.278590176234, 5608.495235428821, 5696.829095127153, 5719.313682358123, 5735.741891614877, 5750.453706897838, 5107.055194788957, 5161.638685292031, 5182.4299327073995, 5210.505002024802, 5229.215617657363, 5234.057869583493, 5241.8427447176455, 5252.658577192489, 5258.894822103555, 5269.710165940891, 5026.170681837492, 5031.949680503203, 5208.921866172011, 5212.29633999409, 5243.187305967562, 5128.5640720538795, 5129.487051294859, 5163.406208286057, 5165.7158856262895, 5186.040582492214, 5156.92264616031, 5198.636095473318, 5200.6879587224885, 5262.815866430061, 5267.499587539178, 5538.723063846832, 5737.827865164052, 5752.338481074688, 5811.709414529299, 5821.214136091616, 6041.667708276043, 6043.637381757065, 6048.848778780522, 6069.848253793646, 6081.726322315506, 6109.725062372204, 6140.17107690465, 6149.538784591174, 6171.043488259327, 6180.165677633552, 5614.578906582023, 5659.094544872883, 5663.546916246691, 5743.856403589902, 5752.28096487939, 6181.567290289637, 6268.780592679234, 6270.686465676789, 6276.497880169575, 6292.937070629327, 6010.729517171738, 6015.187949626832, 6030.849228769228, 6049.364816694272, 6060.2424696912885, 5951.672658003851, 6028.065649824284, 6092.1775560299675, 6101.725422356005, 6111.388861113942, 6003.8198854034445, 6091.695415229221, 6096.420840020191, 6107.029699522994, 6152.477039451607, 6096.014717947461, 6115.209918062534, 6137.285055221507, 6161.876762464725, 6169.8457538561, 4592.311153327028, 4752.7623618818925, 4754.881127971828, 4756.476787553366, 4760.928586071212, 4094.467719196485, 4171.770552619635, 4185.832566697298, 4235.0, 4237.067845074079, 5804.332501762351, 5806.564507661942, 5809.622374545641, 5828.0966450200285, 5836.678982655994, 5834.824955251349, 5893.351731309553, 6150.384961503813, 6167.753289868355, 6170.0, 5742.483176514133, 5757.165211044459, 5779.768809247667, 5878.970605146947, 5900.793472228452, 5163.148080566664, 5179.0, 5215.739213039333, 5220.660657057279, 5227.424983251915, 6264.185655864709, 6309.905351419732, 6310.810675679737, 6318.304986451487, 6323.114763932961, 5890.793822216202, 6026.789062382795, 6126.050462178369, 6177.62934223948, 6178.7219575120125, 6332.461740752087, 6336.936630633634, 6337.588056776479, 6338.841528961629, 6350.650714210763, 6085.756569737161, 6102.694865256631, 6106.3588323227195, 6121.265448146251, 6125.0, 5948.078047902409, 6012.759489620541, 6102.084687296941, 6127.464420129145, 6128.4790792783115, 6062.211912451353, 6072.05883088122, 6072.514198863992, 6096.0855871619615, 6126.816195514141, 6069.150318955438, 6073.331933487401, 6082.2701275847185, 6086.360932102066, 6092.238470191226, 5656.095024796013, 5746.224259725051, 5763.596548241583, 6000.729967151576, 6021.668808215591, 5959.404059594006, 6001.4298641628975, 6020.4280593343565, 6059.878802424015, 6084.33072362031, 5849.0, 5885.0, 5885.588008839341, 5895.764169433174, 5921.526277897672], "value": 5636.6844704668465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3027873920579, 634.9587276827008, 646.4020780777779, 656.5896314803251, 689.0904006711137, 39890.202195956066, 44695.55304446955, 44762.0, 44954.0, 45135.77432112839, 44769.7761511192, 45010.54989450105, 45247.773761131146, 45347.09305813882, 45456.0, 8852.114788521145, 8949.686760963368, 8974.0, 8978.326625503081, 8978.775530611721, 8550.0, 8566.271866891322, 8634.870476942819, 8643.0, 8660.263877570414, 8846.867296990518, 8852.203301702877, 8887.73336799897, 8905.198532132106, 8910.064443233465, 8809.295256379506, 8834.160754728291, 8874.29005679544, 8879.334049946248, 8900.109989001114, 8759.255463285628, 8811.0, 8820.691275805317, 8830.823383532294, 8831.514266715329, 42318.0, 42613.78693106546, 42680.0, 42691.786541067406, 42738.0, 3680.5399325084363, 3899.473571067898, 3970.8014599269923, 4158.147579746175, 4325.891852703676, 33637.495437568454, 33685.83157084223, 33690.32619347624, 33728.32543349119, 33822.0, 4543.659225558096, 4555.111753208126, 4560.703554268962, 4574.634029277683, 4683.7892294846815, 350140.0, 353426.0, 353489.0, 354008.0, 354649.0, 62357.376426235154, 62481.68759156266, 62699.68650156811, 62737.0, 63270.36729632737, 40002.0, 40944.795276023426, 41032.58967410288, 43357.0, 43569.12861742747, 15781.526554203392, 15836.129012904401, 15869.761953570705, 15901.681966360607, 15927.920360398124, 13772.449102036007, 13833.170009799444, 13849.376778045013, 13945.302734863217, 14004.08973416745, 9421.717348479557, 9651.71044868655, 9675.661351852652, 9844.9015509844, 21005.36983890486, 7314.597697126709, 7416.0, 7724.0, 7747.0, 7752.922470775333, 1062.7927554127025, 1066.3069005146563, 1070.6413351527326, 1092.9289596176222, 1098.9394536216598, 32474.0, 32965.34069318648, 32999.67000329966, 33008.3398332032, 33315.66684333126, 1137.323292640894, 1159.918805683594, 1198.1852340408432, 1207.1791181996327, 1246.0716766009382, 16663.416780412626, 17259.654806904044, 17717.911410443125, 17935.820641793416, 17987.280508779502, 483805.0, 485944.0, 489041.0, 493175.0, 495739.0, 61344.38655613476, 61767.382326176164, 62001.37998619956, 62200.0, 62496.0, 1444.2634256529245, 1445.6024593236943, 1454.0, 1454.403694485256, 1499.572621802781, 32299.51550726788, 34130.65869341275, 34724.82637586796, 34782.0, 34862.65137348594, 54547.72726136344, 54574.0, 54942.725286373316, 54986.0, 55211.0, 462468.0, 462600.0, 464139.0, 464711.0, 466875.0, 30420.087397378113, 31164.065078047694, 31190.688093119687, 31204.843975779975, 31281.530777038817, 40879.0, 48327.0, 49300.75349623229, 52912.20631690605, 52949.735251323495, 41258.793706031276, 41565.792171040164, 42693.505727299394, 43056.0, 43818.780906095264, 43243.35134972915, 43530.34704479372, 43592.12815743604, 44129.55870441254, 44327.33508997432, 43488.56511434845, 43794.781026094664, 43924.0, 44216.77891610521, 44298.55701442944, 35231.47152792761, 37012.259754805295, 37772.43341349827, 38114.0, 38136.618633813305, 28873.133805985854, 28974.0, 29201.0, 29389.853050735466, 29452.852735736185], "value": 20353.758670343825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.15339091730186, 433.3175248982852, 435.50135095315846, 436.2692490079117, 439.45288116295217, 18660.626787464244, 19323.613527729456, 20116.0, 20339.983000849934, 20463.693044604322, 18156.0, 19823.801761982377, 20264.0, 20272.0, 20434.284800032, 5616.213730077782, 5810.796622118227, 5836.5914385993, 5887.4406931341455, 5891.0, 5740.569457290699, 5743.569232307573, 5809.796657117002, 5856.9414305857035, 5941.732622031997, 6063.514918806485, 6093.482054025413, 6099.451049405553, 6120.418560236771, 6130.938690613104, 5891.0, 6003.099535069731, 6004.489618382443, 6036.9737144685505, 6081.452669259766, 5784.623999440065, 5817.0, 5826.854328641775, 5838.503727183194, 5868.530517558585, 13257.801132983013, 13271.203727776365, 13402.865971340358, 13572.321383930765, 13601.115927464683, 2380.523895220963, 2442.853428794278, 2523.5079159563893, 2538.695356557225, 2908.3601607646283, 9935.552900119439, 9964.25268104895, 10126.088652021353, 10187.134093602053, 10263.589456421734, 1849.824266694662, 1972.5857569910336, 2004.258424382973, 2035.155410504639, 2049.1700861151257, 89401.0, 89866.5506672469, 89953.10046899578, 90854.54572727095, 91207.54396228043, 11793.351365674971, 11975.88024119765, 12151.210171338835, 12230.633081007583, 12292.877071229352, 17228.397006104977, 17307.653846922993, 17366.65266694659, 17403.390881319094, 17443.30226790914, 8175.182481751777, 8423.284020858173, 8431.451955622864, 8447.408681392366, 8610.813998820477, 7736.806579835549, 7741.458097933203, 7758.612069396508, 7804.84390312202, 7897.0, 5013.849584512471, 5152.149895267314, 5185.662931909414, 5189.091908915924, 5346.866328341823, 2153.2894144932447, 2177.54271602962, 2192.9122835086737, 2207.5253820428684, 2245.360072379364, 883.9248663863643, 945.9574319155516, 1040.9167266618804, 1118.1893127482672, 1126.3129491010477, 20003.799962000485, 20334.389968300973, 20484.18063277482, 20499.0, 20729.45246331849, 1017.8982101789762, 1048.916086713061, 1067.1676092647747, 1116.0792346314324, 1122.354646078508, 11067.335959842436, 11242.100631949424, 11482.48328825205, 11532.769344613062, 11534.653960381202, 434074.0, 436875.0, 446547.0, 447910.0, 449045.0, 92871.0, 95179.04820951702, 95984.52007739917, 96540.51729741307, 99894.5005274969, 1013.8225810483136, 1051.6476980211562, 1083.5990683447017, 1095.0691911875, 1100.5982816272003, 17508.299668013136, 17722.202500887233, 17961.281548737905, 18040.18819153115, 18357.632847343244, 42397.0, 42421.575784242996, 42634.0, 42762.57237427586, 43251.78374108109, 55779.0, 59753.701231493564, 60672.696636516535, 60955.69522152361, 61651.691741541006, 8252.958735206286, 8435.072142064246, 8494.0, 8733.65065397377, 8853.0, 11943.223690460092, 12813.295268760308, 12958.935205323913, 13025.869741302466, 13517.932410337886, 6058.0610005449225, 9402.905970940477, 9715.902840971783, 11349.602763903224, 11772.764544709229, 11458.255213411101, 11557.47991340375, 11680.182387232811, 12098.939505302416, 12424.689382765504, 12037.217580857216, 12159.939200303941, 12165.635030949086, 12301.815472768094, 12387.442565084773, 8435.83128337442, 8508.27679647237, 8558.957205213934, 8601.182887625666, 8837.337199709918, 11592.710182245512, 11661.183717139718, 11752.177347585586, 11768.058555315725, 11803.645890623295], "value": 9374.321415788707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.4894935721857, 1530.525537083504, 1669.2238109279183, 1789.758382618346, 1818.2999545175103, 7969.840603187933, 8166.060902996142, 8499.787505312363, 9028.097190280976, 9051.502167380791, 8487.44831585948, 8702.303815694746, 8708.0, 8908.51003194824, 9003.549822508881, 2455.116158183057, 2458.0782206672498, 2475.517274131545, 2488.1664642344745, 2490.1906880263896, 2435.622478515833, 2500.2124330835727, 2522.2055052658447, 2525.217182673368, 2525.217182673377, 2446.6085426331792, 2448.045262347686, 2449.80401567875, 2459.090136649433, 2462.655228268035, 2382.725986511556, 2406.302172370011, 2407.9398015049587, 2413.2036427978815, 2418.0207016158483, 2338.824588155895, 2366.2782851230368, 2399.5800734871327, 2401.795847352977, 2403.182917807936, 9005.099490050943, 9014.549272536347, 9026.729198124001, 9099.454032757989, 9099.818003639957, 5372.758225879845, 5447.618666693333, 5487.149491828773, 5488.725563721838, 5494.230807686927, 3516.40221162403, 3587.264610754789, 3594.7663401879054, 3596.28074385124, 3663.285659296438, 1189.4766302826815, 1200.3818033712646, 1220.78025955328, 1241.8323526324011, 1253.8181963615225, 12693.555725549653, 12694.174878632952, 12700.364981750876, 12760.80858787119, 12772.105952583323, 4657.127624317351, 4758.286257061399, 4779.402574678165, 4865.635077369211, 4870.245112007645, 10528.263021588415, 10539.94730026345, 10553.366797992145, 10564.947175264075, 10570.735731606772, 5499.532539734168, 5509.090999984957, 5541.085720856095, 5561.6663000220115, 5564.610477266552, 4961.280614310905, 5017.297578339036, 5062.417821950523, 5090.541851233407, 5209.895802083937, 4036.8183431745056, 4047.615476529725, 4097.8975525612095, 4128.3601041838565, 4130.483689538808, 1231.759806837676, 1253.4359538207843, 1259.250745806262, 1264.987350126487, 1266.639007882749, 997.2271489595477, 1021.5862575656871, 1059.2638116509106, 1065.105311538296, 1077.5151181968147, 6195.628262304276, 6306.306306306303, 6348.936595606354, 6367.885620016571, 6381.872362552723, 487.4199702354187, 1038.99480502597, 1072.0726571515738, 1077.1221454514703, 1125.5329038448951, 4228.090960443458, 4263.8081286342185, 4315.331123675835, 4374.606285434326, 4486.371907932892, 11033.448327583588, 11319.037881779976, 11370.31778093317, 11398.259113157617, 11445.0, 11038.724031899266, 11087.445627718582, 11192.216544841784, 11398.94300528492, 11407.144464165054, 8363.95818020906, 8453.070162282143, 8498.915010849936, 8666.176713212235, 8677.6528938843, 6064.969675151596, 6105.236845394325, 6155.84610384744, 6239.719212635533, 6262.40507151838, 10221.540030698488, 10321.380717156995, 10359.430231337348, 10399.740006499898, 10404.58381664725, 10187.43969081678, 10249.897501024894, 10461.738456538647, 10592.841107383549, 10593.470326483799, 7514.661840217094, 7541.396688264816, 7698.0, 7703.191164927826, 7714.575698336421, 8795.868061979203, 8806.20744133031, 8832.779180520538, 8848.646054157762, 8851.380403371702, 7924.366050715814, 7938.483998540077, 8004.319632831041, 8031.437799353989, 8084.312833408991, 7852.0, 7880.645370958206, 7927.920720792718, 7935.365170786208, 7977.880331794911, 7354.1910389856, 7358.227386124594, 7376.077990251219, 7397.96301018513, 7428.182899881117, 5332.253484512094, 5347.732613369394, 5418.008105681431, 5434.130539113723, 5508.063629182969, 5293.100172970528, 5341.092014357491, 5376.059189641719, 5455.18172274162, 5459.099248623933], "value": 4821.79377151068, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.34972876669946, 352.09160366255065, 352.2743149112828, 353.409805624607, 354.41344574728834, 5716.371199168093, 5719.828405147842, 5773.913391299128, 5776.971115144418, 5804.854878628036, 5606.0, 5625.76233228689, 5628.183913332565, 5640.210370548127, 5653.0, 3967.4048892666187, 4231.06916478375, 4384.539623339551, 4443.733375997434, 4447.1995040892625, 4447.466304043519, 4447.955520444786, 4463.196624607569, 4471.374007638917, 4479.2609219478745, 4458.9331160032625, 4460.130274596455, 4460.420145381112, 4469.748470428285, 4472.843450479234, 4191.371294305848, 4288.48538175421, 4330.696851220416, 4455.554444555551, 4460.8438704645505, 3836.0, 3840.7311488195837, 3842.846286148551, 3848.730588858781, 3854.498915141042, 5500.0, 5509.1268968550485, 5541.362743284533, 5555.50000499957, 5555.833325000256, 4897.8775530611665, 4981.12830254704, 4985.925211121836, 5004.574611158056, 5044.259730393009, 5892.175095486636, 5906.527477801808, 5940.881182376372, 5941.702914854283, 5944.762209511614, 4166.562510936338, 4175.603317684815, 4240.448741663595, 4241.1941731071, 4255.425517555122, 6095.238095238095, 6114.510839132903, 6136.96931515344, 6171.611387437835, 6221.377862213788, 4297.59172878576, 4305.16049370376, 4309.439772829513, 4311.1808756336195, 4312.568743125662, 4427.136708341843, 4433.667474939392, 4436.889077773081, 4440.578145076277, 4440.977795111004, 4735.431748190239, 4937.802487900443, 5004.2493625956395, 5055.443901170868, 5064.316317297192, 5947.762089516371, 5950.226470558886, 5960.7019649017375, 5991.580589358703, 6006.189164462829, 1468.3612628506635, 1472.5876754508754, 1475.2844870237925, 1479.8742106921031, 1480.3116550803927, 983.3362480325751, 1019.6584144311738, 1027.306568066552, 1033.963811266617, 1043.1602559939322, 5500.724963751796, 5539.723013849372, 5543.556515478752, 5573.4394369575775, 5583.096789669349, 5887.0, 5927.2590926134235, 5941.465268125803, 5942.276739745512, 5968.970550013017, 5415.593830462731, 5524.281843360337, 5725.914111288334, 5797.4782269595935, 5801.593888427769, 3186.1556687477837, 3197.2965947491516, 3199.9760076775674, 3208.9358212836078, 3214.100051985448, 6035.130308472133, 6050.0, 6096.847578810565, 6182.381761823782, 6207.379262073847, 6039.365866583946, 6107.8473038173515, 6115.847103822351, 6118.776244750979, 6139.631622102688, 6249.937500625027, 6270.843228919313, 6279.529035322278, 6280.995040793542, 6282.340354262737, 6134.0, 6160.969195153995, 6166.506679465721, 6168.167297414791, 6192.164057852313, 6005.489533389711, 6041.486473649789, 6082.878342433038, 6108.35862234459, 6120.1125836752535, 6257.4681152102585, 6274.14912600793, 6279.277883043508, 6294.590851594632, 6296.0, 4263.189993901149, 4369.628581570602, 4399.472063352418, 4415.977920110379, 4416.514183439884, 6156.0, 6159.322474527708, 6162.722677479614, 6171.876562468815, 6176.876462470816, 5974.731137098754, 6008.669523176267, 6028.517718582415, 6063.757449701962, 6065.604910870613, 5811.56413268998, 5957.6127551709, 6004.309504407049, 6006.279246490449, 6021.367756385516, 5942.58401911862, 5958.970205148947, 5968.16445697594, 5975.850603734942, 6006.249218847644, 5923.585349025527, 5979.162917191684, 6007.699615019319, 6078.331383547895, 6084.269887613515, 5817.9127313091185, 5848.94718950593, 5849.034909239927, 5868.794592189423, 5934.762609495572], "value": 4522.862481315323, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.16768644453, 806.620888182554, 828.9295409890159, 835.3233880556749, 896.730980705788, 15642.765358519631, 16035.438759643415, 16141.192940352994, 16141.515754527354, 16296.103714295723, 14675.77986330206, 14818.333175007123, 14821.333040013198, 14841.480548180816, 14842.406303747865, 857.7255278310943, 868.769776009358, 872.6640243506264, 872.9829748343172, 873.10506730601, 855.4183155454289, 861.0571424290392, 869.2915274051659, 870.0299166429418, 873.0789017586444, 901.5086777706133, 904.159132007233, 908.7682640926588, 909.4406939732083, 914.7210100919217, 895.6909866096187, 897.6364572348144, 898.2454738020061, 901.4320977783987, 905.9094090590954, 666.3503084492629, 666.7799626123368, 671.684308375063, 671.9899201511981, 673.0005941177347, 13352.0, 13421.127626704232, 13458.730825383536, 13465.865341346656, 13499.86500134996, 12844.0, 13084.345782710827, 13168.407421665952, 13245.536406225832, 13273.601791946257, 11267.492962816694, 11324.50594457037, 11331.773364532663, 11333.0, 11449.771004579945, 3790.33669107905, 3818.1218319786326, 3876.0, 3910.6284902934176, 3918.040080180374, 56343.71828140833, 57756.71121644407, 59752.70123649397, 63800.36199638037, 64485.355146448404, 11229.0, 11327.660170194908, 11460.083193344512, 11488.0, 11610.941945290388, 20710.275140370013, 20803.68794468084, 20806.687899681518, 20826.583468330547, 20981.055852486676, 8809.383343165917, 8907.287417006624, 8918.598663060178, 9123.81752364949, 9344.626214951462, 4977.452480227172, 4985.501449854985, 5035.320231768665, 5064.088464076428, 5126.5898728101665, 3550.0592343029116, 3677.963220367762, 3692.150805314739, 3702.833372498244, 3711.183539621279, 668.2749217099405, 668.5520701130255, 677.9118714567173, 688.9276625954303, 691.8512519808165, 637.6014990630856, 659.8218481010197, 676.8307923019245, 741.2180149941755, 742.9294217049371, 9257.398269112486, 9450.669226577036, 9676.225901927828, 9679.854802177973, 9866.062724041205, 641.5637366590763, 745.5861996591943, 757.0914902117481, 777.3780975219802, 785.3167744062702, 4391.714538554984, 4404.493483249467, 4620.932155272867, 4717.787699553528, 4751.263554149113, 89457.0, 90292.0, 91643.0, 94239.52880235555, 94732.0, 64911.35088649053, 67374.66312668503, 80825.59587202026, 82345.0, 84552.57723711342, 66581.66709166423, 69258.0, 69280.0, 70129.29870701431, 70262.0, 8584.270337021424, 8826.5586720665, 9012.233960113464, 9309.348345615741, 9317.767055823659, 36046.45930310995, 41413.378799317434, 44969.0, 47049.76475117602, 47140.7642961783, 61767.0, 63917.68041159764, 66055.34861628305, 66404.33595663981, 67365.0, 11806.586769463027, 11911.880881191077, 11945.641630751092, 12060.396980151132, 12539.310337931502, 13434.529791457253, 13904.096233744775, 13965.930170349084, 13966.930165349107, 13971.30143492801, 12126.757464850478, 12343.444544995677, 12386.31875246834, 12698.809517857424, 13009.284489353176, 11809.409529523318, 12067.456964436446, 12788.552400666304, 12789.42447589842, 12822.23066616006, 12852.55016074433, 12853.614391568268, 12974.35128243603, 13093.476260949456, 13612.65968350799, 10495.41795604014, 10619.893801061891, 10815.35107893529, 10963.56145754161, 10983.340999540053, 10749.516271767945, 11009.394483303175, 11039.369921340334, 11040.779184416428, 11418.0865530759], "value": 7292.793408768946, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 114.0, 111.0, 113.0, 111.0, 113.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 119.0, 162.0, 126.0, 118.0, 121.0, 119.0, 147.0, 122.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 163.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 110.0, 75.0, 76.0, 75.0, 75.0, 101.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 83.0, 83.0, 82.0, 98.0, 81.0, 81.0, 120.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 51.0, 52.0, 54.0, 51.0, 52.0, 55.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 79.0, 75.0, 75.0, 75.0, 74.0, 79.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 124.0, 122.0, 121.0, 121.0, 130.0, 131.0, 166.0, 131.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 156.0, 153.0, 158.0, 154.0, 156.0, 154.0, 154.0, 153.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 64.0], "value": 62.6, "unit": "score"}]}]} 02:51:38 INFO - Return code: 0 02:51:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:51:39 ERROR - # TBPL SUCCESS # 02:51:39 INFO - Running post-action listener: _resource_record_post_action 02:51:39 INFO - [mozharness: 2017-01-05 10:51:39.055207Z] Finished run-tests step (success) 02:51:39 INFO - Running post-run listener: _resource_record_post_run 02:51:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 353669120; Read time: 0; Write time: 586984 02:51:39 INFO - TinderboxPrint: CPU usage
13.4% 02:51:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:51:39 INFO - TinderboxPrint: I/O write bytes / time
353,669,120 / 586,984 02:51:39 INFO - TinderboxPrint: CPU idle
8,238.4 (86.6%) 02:51:39 INFO - TinderboxPrint: CPU user
1,207.2 (12.7%) 02:51:39 INFO - TinderboxPrint: Swap in / out
0 / 0 02:51:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 109236224; Read time: 0; Write time: 286904 02:51:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 243470336; Read time: 0; Write time: 299140 02:51:39 INFO - Running post-run listener: _upload_blobber_files 02:51:39 INFO - Blob upload gear active. 02:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:39 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 02:51:39 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'] 02:51:39 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 02:51:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:41 INFO - (blobuploader) - INFO - Done attempting. 02:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:42 INFO - (blobuploader) - INFO - Done attempting. 02:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:45 INFO - (blobuploader) - INFO - Done attempting. 02:51:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:45 INFO - Return code: 0 02:51:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:51:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb5ad689fbfab3fbe07e8b260087ffcf83e713f774cb53759c5ca47a3dffb575e3adcc9c4c8cef6eaa0c9980b0ddab3723189a084a34640ef23824b0da9785ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebb8e67adb01a2bea251f8b81cbc42b1eea2e72d7afbabd601c7631f4585a306d615c199b3b7b071194653e46ee0a55b9ea9cc6559f21c48a9276b6efd3963f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319b34d3b3e3d846fd1006aa7864e91fa44019bc3ef872df6441d8d461f2b2853e177d32cfec494054c9a8afc9b9ec9742a3010291ac6ac70581d0d0e2f349"} 02:51:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:51:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:51:45 INFO - Contents: 02:51:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb5ad689fbfab3fbe07e8b260087ffcf83e713f774cb53759c5ca47a3dffb575e3adcc9c4c8cef6eaa0c9980b0ddab3723189a084a34640ef23824b0da9785ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebb8e67adb01a2bea251f8b81cbc42b1eea2e72d7afbabd601c7631f4585a306d615c199b3b7b071194653e46ee0a55b9ea9cc6559f21c48a9276b6efd3963f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319b34d3b3e3d846fd1006aa7864e91fa44019bc3ef872df6441d8d461f2b2853e177d32cfec494054c9a8afc9b9ec9742a3010291ac6ac70581d0d0e2f349"} 02:51:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:45 INFO - Copying logs to upload dir... 02:51:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:51:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.750373 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-05 02:51:44.707889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:51:44.715985) ========= 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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb5ad689fbfab3fbe07e8b260087ffcf83e713f774cb53759c5ca47a3dffb575e3adcc9c4c8cef6eaa0c9980b0ddab3723189a084a34640ef23824b0da9785ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebb8e67adb01a2bea251f8b81cbc42b1eea2e72d7afbabd601c7631f4585a306d615c199b3b7b071194653e46ee0a55b9ea9cc6559f21c48a9276b6efd3963f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319b34d3b3e3d846fd1006aa7864e91fa44019bc3ef872df6441d8d461f2b2853e177d32cfec494054c9a8afc9b9ec9742a3010291ac6ac70581d0d0e2f349"} build_url:https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/elBik5SbT-ieS1x1_i_G0A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb5ad689fbfab3fbe07e8b260087ffcf83e713f774cb53759c5ca47a3dffb575e3adcc9c4c8cef6eaa0c9980b0ddab3723189a084a34640ef23824b0da9785ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebb8e67adb01a2bea251f8b81cbc42b1eea2e72d7afbabd601c7631f4585a306d615c199b3b7b071194653e46ee0a55b9ea9cc6559f21c48a9276b6efd3963f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319b34d3b3e3d846fd1006aa7864e91fa44019bc3ef872df6441d8d461f2b2853e177d32cfec494054c9a8afc9b9ec9742a3010291ac6ac70581d0d0e2f349"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:51:44.744714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:51:44.745034) ========= 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=5cf47e208febbcd81da23b2e0000026f-1483612267.154189-133015148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:51:44.833077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:51:44.833690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:51:44.834256) ========= ========= Total master_lag: 0.19 =========